[59.364390] Initializing watchdogs [59.364440] /dev/watchdog0 [59.378361] [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.382634] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.385429] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.388433] [001/133] (960s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [59.510870] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [59.513162] Starting dynamic subtest: pipe-A-default-mode [60.701840] Dynamic subtest pipe-A-default-mode: SKIP (1.193s) [60.706277] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.194s) [60.865918] [002/133] (959s left) kms_ccs (bad-rotation-90-y-tiled-gen12-mc-ccs) [60.955463] Starting subtest: bad-rotation-90-y-tiled-gen12-mc-ccs [60.957769] Starting dynamic subtest: pipe-A-eDP-1 [60.988088] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [60.996124] Starting dynamic subtest: pipe-B-eDP-1 [61.017095] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [61.024070] Starting dynamic subtest: pipe-C-eDP-1 [61.044778] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [61.051643] Starting dynamic subtest: pipe-D-eDP-1 [61.073906] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [61.078232] Subtest bad-rotation-90-y-tiled-gen12-mc-ccs: SKIP (0.003s) [63.231158] [003/133] (956s left) kms_content_protection (uevent-hdcp14) [63.376563] Starting subtest: uevent-hdcp14 [63.381148] Subtest uevent-hdcp14: SKIP (0.000s) [63.489624] [004/133] (956s left) kms_psr (fbc-psr-cursor-plane-onoff) [63.577176] Starting subtest: fbc-psr-cursor-plane-onoff [63.579142] Starting dynamic subtest: eDP-1 [63.583113] Dynamic subtest eDP-1: SKIP (0.000s) [63.587058] Subtest fbc-psr-cursor-plane-onoff: SKIP (0.000s) [63.641201] [005/133] (956s left) kms_getfb (getfb-handle-zero) [63.728984] Starting subtest: getfb-handle-zero [63.731398] Subtest getfb-handle-zero: SUCCESS (0.000s) [63.823945] [006/133] (956s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [63.891069] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [63.970836] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.030s) [64.005546] [007/133] (956s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs) [64.071530] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs [64.076074] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s) [64.249512] [008/133] (955s left) gem_exec_schedule (independent) [64.319957] Starting subtest: independent [64.322063] Starting dynamic subtest: rcs0 [65.877798] Dynamic subtest rcs0: SUCCESS (1.568s) [65.888087] Starting dynamic subtest: vcs0 [68.078488] Dynamic subtest vcs0: SUCCESS (2.202s) [68.087445] Starting dynamic subtest: vcs1 [69.923968] Dynamic subtest vcs1: SUCCESS (1.846s) [69.934382] Starting dynamic subtest: vecs0 [71.907299] Dynamic subtest vecs0: SUCCESS (1.985s) [71.918312] Starting dynamic subtest: ccs0 [73.877241] Dynamic subtest ccs0: SUCCESS (1.970s) [73.879711] Subtest independent: SUCCESS (9.577s) [74.178701] [009/133] (945s left) gem_exec_params (invalid-bsd-ring) [74.233597] Starting subtest: invalid-bsd-ring [74.235964] Subtest invalid-bsd-ring: SUCCESS (0.000s) [74.325884] [010/133] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite) [74.428720] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite [83.052942] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (8.631s) [83.169955] [011/133] (937s left) gem_reg_read (timestamp-monotonic) [83.237951] Starting subtest: timestamp-monotonic [87.533473] Subtest timestamp-monotonic: SUCCESS (4.296s) [87.604509] [012/133] (932s left) kms_big_fb (y-tiled-32bpp-rotate-270) [87.714395] Starting subtest: y-tiled-32bpp-rotate-270 [87.718664] Subtest y-tiled-32bpp-rotate-270: SKIP (0.000s) [87.809751] [013/133] (932s left) kms_lease (lease-invalid-crtc) [87.897913] Starting subtest: lease-invalid-crtc [87.900346] Starting dynamic subtest: pipe-A-eDP-1 [87.902650] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [87.911142] Starting dynamic subtest: pipe-B-eDP-1 [87.913405] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [87.920108] Starting dynamic subtest: pipe-C-eDP-1 [87.922408] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [87.929795] Starting dynamic subtest: pipe-D-eDP-1 [87.932052] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [87.934229] Subtest lease-invalid-crtc: SUCCESS (0.002s) [87.966563] [014/133] (932s left) gem_render_copy (linear) [88.018895] Starting subtest: linear [88.021158] Starting dynamic subtest: smem [88.058623] Dynamic subtest smem: SUCCESS (0.040s) [88.061344] Subtest linear: SUCCESS (0.040s) [88.280799] [015/133] (932s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc) [88.385323] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc [95.409080] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (7.028s) [95.521176] [016/133] (924s left) gem_eio (create-ext) [95.748080] Starting subtest: create-ext [96.066037] Subtest create-ext: SUCCESS (0.316s) [96.192097] [017/133] (924s left) core_getstats (basic) [96.241519] Starting subtest: basic [96.243600] Subtest basic: SUCCESS (0.000s) [96.338353] [018/133] (924s left) kms_big_fb (x-tiled-64bpp-rotate-270) [96.443956] Starting subtest: x-tiled-64bpp-rotate-270 [96.463393] Subtest x-tiled-64bpp-rotate-270: SKIP (0.019s) [96.583931] [019/133] (923s left) syncobj_wait (invalid-single-wait-unsubmitted) [96.643315] Starting subtest: invalid-single-wait-unsubmitted [96.645043] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [96.731562] [020/133] (923s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [96.825905] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [96.829801] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [96.911817] [021/133] (923s left) kms_invalid_mode (zero-hdisplay) [97.000454] Starting subtest: zero-hdisplay [97.002360] Starting dynamic subtest: pipe-A-eDP-1 [97.281087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.284s) [97.289767] Starting dynamic subtest: pipe-B-eDP-1 [97.292033] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [97.299342] Starting dynamic subtest: pipe-C-eDP-1 [97.301507] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [97.309163] Starting dynamic subtest: pipe-D-eDP-1 [97.311060] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [97.312928] Subtest zero-hdisplay: SUCCESS (0.288s) [98.092951] [022/133] (922s left) kms_flip (2x-flip-vs-modeset-vs-hang) [98.189118] Starting subtest: 2x-flip-vs-modeset-vs-hang [98.197336] Subtest 2x-flip-vs-modeset-vs-hang: SKIP (0.010s) [98.303541] [023/133] (922s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [98.404036] Starting subtest: nonblocking-crc-frame-sequence [98.406610] Starting dynamic subtest: pipe-A-eDP-1 [99.172991] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.768s) [99.180847] Starting dynamic subtest: pipe-B-eDP-1 [100.592611] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.420s) [100.602268] Starting dynamic subtest: pipe-C-eDP-1 [101.990881] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.398s) [102.000504] Starting dynamic subtest: pipe-D-eDP-1 [103.328540] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.335s) [103.330726] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.925s) [104.130783] [024/133] (916s left) i915_drm_fdinfo (isolation) [104.171095] Starting subtest: isolation [104.172908] Starting dynamic subtest: rcs0 [104.192055] Dynamic subtest rcs0: SKIP (0.020s) [104.199644] Starting dynamic subtest: bcs0 [104.203632] Dynamic subtest bcs0: SKIP (0.001s) [104.210890] Starting dynamic subtest: vcs0 [104.215147] Dynamic subtest vcs0: SKIP (0.001s) [104.222184] Starting dynamic subtest: vcs1 [104.226205] Dynamic subtest vcs1: SKIP (0.000s) [104.232936] Starting dynamic subtest: vecs0 [104.237130] Dynamic subtest vecs0: SKIP (0.000s) [104.243900] Starting dynamic subtest: ccs0 [104.248031] Dynamic subtest ccs0: SKIP (0.000s) [104.252149] Subtest isolation: SKIP (0.025s) [104.285406] [025/133] (916s left) kms_chamelium_edid (hdmi-edid-stress-resolution-non-4k) [104.668796] Subtest hdmi-edid-stress-resolution-non-4k: SKIP (0.000s) [105.431901] [026/133] (915s left) gem_pxp (hw-rejects-pxp-buffer) [105.543436] Starting subtest: hw-rejects-pxp-buffer [105.548561] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [105.660385] [027/133] (915s left) kms_frontbuffer_tracking (fbc-tiling-4) [105.761757] Starting subtest: fbc-tiling-4 [109.963454] Subtest fbc-tiling-4: SUCCESS (4.205s) [111.161391] [028/133] (909s left) gem_fence_thrash (bo-write-verify-threaded-none) [111.205624] Starting subtest: bo-write-verify-threaded-none [111.229568] Subtest bo-write-verify-threaded-none: SKIP (0.022s) [111.289538] [029/133] (909s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier) [111.379172] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier [111.384149] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier: SKIP (0.000s) [111.451969] [030/133] (909s left) gen9_exec_parse (basic-rejected-ctx-param) [111.515426] Subtest basic-rejected-ctx-param: SKIP (0.000s) [111.587347] [031/133] (909s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt) [111.686616] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt [111.691238] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [111.783896] [032/133] (909s left) kms_psr (pr-dpms) [111.885980] Starting subtest: pr-dpms [111.890443] Subtest pr-dpms: SKIP (0.000s) [111.955099] [033/133] (909s left) i915_selftest (live) [115.208700] Starting subtest: live [115.210734] Starting dynamic subtest: sanitycheck [119.468530] Dynamic subtest sanitycheck: SUCCESS (4.262s) [119.476218] Starting dynamic subtest: uncore [123.754606] Dynamic subtest uncore: SUCCESS (4.285s) [123.763325] Starting dynamic subtest: workarounds [141.752826] Dynamic subtest workarounds: FAIL (17.867s) [141.760441] Starting dynamic subtest: gt_engines [146.177066] Dynamic subtest gt_engines: SUCCESS (4.553s) [146.191228] Starting dynamic subtest: gt_timelines [161.935351] Dynamic subtest gt_timelines: SUCCESS (15.755s) [161.944482] Starting dynamic subtest: gt_contexts [164.670600] Dynamic subtest gt_contexts: SUCCESS (2.734s) [164.679686] Starting dynamic subtest: gt_lrc [170.698615] Dynamic subtest gt_lrc: SUCCESS (6.026s) [170.707896] Starting dynamic subtest: gt_mocs [173.556892] Dynamic subtest gt_mocs: SUCCESS (2.857s) [173.565815] Starting dynamic subtest: gt_pm [180.304182] Dynamic subtest gt_pm: SUCCESS (6.746s) [180.313378] Starting dynamic subtest: gt_heartbeat [184.647804] Dynamic subtest gt_heartbeat: SUCCESS (4.343s) [184.656274] Starting dynamic subtest: gt_tlb [193.959614] Dynamic subtest gt_tlb: SUCCESS (9.310s) [193.968151] Starting dynamic subtest: requests [207.333624] Dynamic subtest requests: SUCCESS (13.373s) [207.342602] Starting dynamic subtest: migrate [213.123296] Dynamic subtest migrate: SUCCESS (5.788s) [213.130586] Starting dynamic subtest: active [217.446088] Dynamic subtest active: SUCCESS (4.321s) [217.455101] Starting dynamic subtest: objects [222.054429] Dynamic subtest objects: SUCCESS (4.607s) [222.061664] Starting dynamic subtest: mman [226.850765] Dynamic subtest mman: SUCCESS (4.794s) [226.859785] Starting dynamic subtest: dmabuf [229.832116] Dynamic subtest dmabuf: SUCCESS (2.980s) [229.842082] Starting dynamic subtest: vma [234.147205] Dynamic subtest vma: SUCCESS (4.313s) [234.156105] Starting dynamic subtest: coherency [238.971979] Dynamic subtest coherency: SUCCESS (4.824s) [238.978768] Starting dynamic subtest: gtt [250.832592] Dynamic subtest gtt: SUCCESS (11.858s) [250.844273] Starting dynamic subtest: gem [258.572766] Dynamic subtest gem: SUCCESS (7.739s) [258.582186] Starting dynamic subtest: evict [262.583372] Dynamic subtest evict: SUCCESS (4.009s) [262.590806] Starting dynamic subtest: hugepages [271.342707] Dynamic subtest hugepages: SUCCESS (8.757s) [271.351640] Starting dynamic subtest: gem_contexts [297.974078] Dynamic subtest gem_contexts: SUCCESS (26.628s) [297.983543] Starting dynamic subtest: client [302.254214] Dynamic subtest client: SUCCESS (4.279s) [302.263587] Starting dynamic subtest: gem_migrate [306.608449] Dynamic subtest gem_migrate: SUCCESS (4.351s) [306.617888] Starting dynamic subtest: reset [310.887095] Dynamic subtest reset: SUCCESS (4.276s) [310.895769] Starting dynamic subtest: memory_region [313.567334] Dynamic subtest memory_region: SUCCESS (2.677s) [313.575754] Starting dynamic subtest: hangcheck [326.123493] Dynamic subtest hangcheck: SUCCESS (12.554s) [326.137835] Starting dynamic subtest: execlists [330.420719] Dynamic subtest execlists: SUCCESS (4.294s) [330.428067] Starting dynamic subtest: ring_submission [334.699229] Dynamic subtest ring_submission: SUCCESS (4.276s) [334.708229] Starting dynamic subtest: perf [339.026739] Dynamic subtest perf: SUCCESS (4.326s) [339.035174] Starting dynamic subtest: slpc [351.110067] Dynamic subtest slpc: SUCCESS (12.080s) [351.119062] Starting dynamic subtest: guc [354.988641] Dynamic subtest guc: SUCCESS (3.876s) [355.002338] Starting dynamic subtest: guc_multi_lrc [359.305455] Dynamic subtest guc_multi_lrc: SUCCESS (4.314s) [359.313881] Starting dynamic subtest: guc_hang [364.126787] Dynamic subtest guc_hang: SUCCESS (4.819s) [364.135683] Starting dynamic subtest: late_gt_pm [366.827381] Dynamic subtest late_gt_pm: SUCCESS (2.700s) [366.829875] Subtest live: FAIL (251.612s) [366.859223] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [366.862403] [034/133] (654s left) kms_addfb_basic (bo-too-small-due-to-tiling) [368.411478] Starting subtest: bo-too-small-due-to-tiling [368.415957] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [368.489407] [FACT kms_addfb_basic (bo-too-small-due-to-tiling)] new: kernel.kmod_is_loaded.i915: true [368.493021] [035/133] (652s left) gem_exec_store (cachelines) [368.563627] Starting subtest: cachelines [368.566146] Starting dynamic subtest: rcs0 [368.638748] Dynamic subtest rcs0: SUCCESS (0.074s) [368.648071] Starting dynamic subtest: bcs0 [368.692200] Dynamic subtest bcs0: SUCCESS (0.051s) [368.704761] Starting dynamic subtest: vcs0 [368.744481] Dynamic subtest vcs0: SUCCESS (0.050s) [368.753501] Starting dynamic subtest: vcs1 [368.804548] Dynamic subtest vcs1: SUCCESS (0.058s) [368.814343] Starting dynamic subtest: vecs0 [368.858283] Dynamic subtest vecs0: SUCCESS (0.052s) [368.869942] Starting dynamic subtest: ccs0 [368.909595] Dynamic subtest ccs0: SUCCESS (0.050s) [368.912238] Subtest cachelines: SUCCESS (0.347s) [369.089061] [036/133] (652s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [369.179884] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [373.611869] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.435s) [374.743462] [037/133] (646s left) gem_wait (await) [374.800045] Starting subtest: await [374.802943] Starting dynamic subtest: all-engines [375.909063] Dynamic subtest all-engines: SUCCESS (1.109s) [375.925556] Starting dynamic subtest: rcs0 [376.965147] Dynamic subtest rcs0: SUCCESS (1.053s) [376.980884] Starting dynamic subtest: bcs0 [378.022172] Dynamic subtest bcs0: SUCCESS (1.055s) [378.037796] Starting dynamic subtest: vcs0 [379.076468] Dynamic subtest vcs0: SUCCESS (1.052s) [379.091549] Starting dynamic subtest: vcs1 [380.131187] Dynamic subtest vcs1: SUCCESS (1.052s) [380.145688] Starting dynamic subtest: vecs0 [381.186117] Dynamic subtest vecs0: SUCCESS (1.053s) [381.203933] Starting dynamic subtest: ccs0 [382.244375] Dynamic subtest ccs0: SUCCESS (1.056s) [382.246814] Subtest await: SUCCESS (7.446s) [382.437668] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true [382.441334] [038/133] (638s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-pwrite) [382.545649] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-pwrite [382.550109] Subtest psr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [382.642315] [039/133] (638s left) syncobj_wait (wait-all-for-submit-complex) [382.690955] Starting subtest: wait-all-for-submit-complex [382.904550] Subtest wait-all-for-submit-complex: SUCCESS (0.213s) [382.992777] [040/133] (638s left) syncobj_timeline (etime-multi-wait-for-submit-available-unsubmitted) [383.048472] Starting subtest: etime-multi-wait-for-submit-available-unsubmitted [383.153403] Subtest etime-multi-wait-for-submit-available-unsubmitted: SUCCESS (0.104s) [383.225338] [041/133] (638s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [383.317631] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [383.321734] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [383.421010] [042/133] (637s left) kms_big_fb (linear-16bpp-rotate-90) [383.518917] Starting subtest: linear-16bpp-rotate-90 [383.541015] Subtest linear-16bpp-rotate-90: SKIP (0.021s) [383.655273] [043/133] (637s left) gem_exec_reloc (basic-write-read-active) [383.713664] Subtest basic-write-read-active: SKIP (0.000s) [383.774916] [044/133] (637s left) gem_create (create-ext-cpu-access-big) [383.947862] Starting subtest: create-ext-cpu-access-big [383.952165] Subtest create-ext-cpu-access-big: SKIP (0.001s) [384.017678] [045/133] (637s left) gem_mmap_wc (bad-size) [384.070132] Subtest bad-size: SKIP (0.000s) [384.121510] [046/133] (637s left) api_intel_allocator (gem-pool) [384.173346] Starting subtest: gem-pool [384.180274] Subtest gem-pool: SUCCESS (0.009s) [384.316946] [047/133] (637s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [384.411077] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [384.415118] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [384.503470] [048/133] (637s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [384.566694] Starting subtest: etime-multi-wait-all-available-unsubmitted [384.672699] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.106s) [384.753522] [049/133] (636s left) gem_mmap_offset (clear) [384.816031] Starting subtest: clear [384.820074] Starting dynamic subtest: smem0 [410.207533] Dynamic subtest smem0: SUCCESS (25.386s) [410.210084] Subtest clear: SUCCESS (25.390s) [410.331792] [050/133] (611s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [410.481641] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [410.486106] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [410.569107] [051/133] (611s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs) [410.682269] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs [410.684574] Starting dynamic subtest: pipe-A-eDP-1 [410.706766] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [410.715440] Starting dynamic subtest: pipe-B-eDP-1 [410.736208] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [410.743498] Starting dynamic subtest: pipe-C-eDP-1 [410.764177] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [410.771450] Starting dynamic subtest: pipe-D-eDP-1 [410.792236] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [410.796095] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs: SKIP (0.006s) [412.992533] [052/133] (608s left) kms_addfb_basic (no-handle) [413.037119] Starting subtest: no-handle [413.039250] Subtest no-handle: SUCCESS (0.000s) [413.183865] [053/133] (608s left) kms_flip (flip-vs-suspend-interruptible) [413.285477] Starting subtest: flip-vs-suspend-interruptible [413.287669] Starting dynamic subtest: A-eDP1 [463.095085] Dynamic subtest A-eDP1: SUCCESS (4.673s) [463.116465] Starting dynamic subtest: B-eDP1 [512.107574] Dynamic subtest B-eDP1: SUCCESS (4.505s) [512.123116] Starting dynamic subtest: C-eDP1 [561.121392] Dynamic subtest C-eDP1: SUCCESS (4.491s) [561.130458] Starting dynamic subtest: D-eDP1 [610.113181] Dynamic subtest D-eDP1: SUCCESS (4.542s) [610.118214] Subtest flip-vs-suspend-interruptible: SUCCESS (18.223s) [611.272908] [054/133] (410s left) i915_pm_rpm (debugfs-read) [612.841370] Starting subtest: debugfs-read [614.005754] Subtest debugfs-read: SUCCESS (1.173s) [614.395705] [055/133] (407s left) gem_exec_balancer (sliced) [614.474214] Starting subtest: sliced [614.479963] Subtest sliced: SKIP (0.000s) [614.769835] [056/133] (407s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled) [614.833433] Starting subtest: multi-wait-available-unsubmitted-signaled [614.836404] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s) [614.907801] [057/133] (407s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic) [615.023848] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic [615.028707] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [615.209600] [058/133] (406s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff) [615.312589] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff [622.393331] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.109s) [622.537486] [059/133] (399s left) kms_cursor_crc (cursor-offscreen-256x256) [622.824141] Starting subtest: cursor-offscreen-256x256 [622.826568] Starting dynamic subtest: pipe-A-eDP-1 [624.763965] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.942s) [624.793702] Starting dynamic subtest: pipe-D-eDP-1 [627.371436] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.589s) [627.373682] Subtest cursor-offscreen-256x256: SUCCESS (4.556s) [628.233893] [060/133] (393s left) syncobj_wait (multi-wait-for-submit-submitted-signaled) [628.288976] Starting subtest: multi-wait-for-submit-submitted-signaled [628.291281] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [628.394802] [061/133] (393s left) perf (oa-exponents) [628.524853] Starting subtest: oa-exponents [628.527090] Starting dynamic subtest: 0-rcs0 [630.302913] Dynamic subtest 0-rcs0: SUCCESS (1.782s) [630.313168] Starting dynamic subtest: 1-vcs0 [632.130160] Dynamic subtest 1-vcs0: SUCCESS (1.828s) [632.132777] Subtest oa-exponents: SUCCESS (3.612s) [632.182844] [062/133] (390s left) gem_workarounds (reset) [632.256719] Starting subtest: reset [632.436928] Subtest reset: SUCCESS (0.178s) [632.571689] [063/133] (389s left) prime_mmap (test_correct) [632.630227] Starting subtest: test_correct [632.632743] Starting dynamic subtest: test_correct-smem [632.669292] Dynamic subtest test_correct-smem: SUCCESS (0.038s) [632.671960] Subtest test_correct: SUCCESS (0.040s) [632.767506] [064/133] (389s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [632.867197] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [633.867218] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.001s) [633.978900] [065/133] (388s left) kms_vrr (seamless-rr-switch-virtual) [634.071525] Starting subtest: seamless-rr-switch-virtual [634.078498] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [634.144831] [066/133] (388s left) kms_cursor_edge_walk (256x256-right-edge) [634.236730] Starting subtest: 256x256-right-edge [634.240958] Starting dynamic subtest: pipe-A-eDP-1 [637.696306] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.461s) [637.707444] Starting dynamic subtest: pipe-D-eDP-1 [640.831342] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.136s) [640.834329] Subtest 256x256-right-edge: SUCCESS (6.599s) [641.634879] [067/133] (380s left) kms_flip (2x-plain-flip-ts-check) [641.727473] Starting subtest: 2x-plain-flip-ts-check [641.735714] Subtest 2x-plain-flip-ts-check: SKIP (0.010s) [641.815317] [068/133] (380s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-blt) [641.922181] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-blt [641.927500] Subtest fbc-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [642.022161] [069/133] (380s left) sw_sync (sync_multi_producer_single_consumer) [642.054959] Starting subtest: sync_multi_producer_single_consumer [643.123737] Subtest sync_multi_producer_single_consumer: SUCCESS (1.076s) [643.198810] [070/133] (379s left) kms_plane_scaling (planes-scaler-unity-scaling) [643.297309] Starting subtest: planes-scaler-unity-scaling [643.300059] Starting dynamic subtest: pipe-A [643.357873] Dynamic subtest pipe-A: SUCCESS (0.063s) [643.370485] Starting dynamic subtest: pipe-B [644.476498] Dynamic subtest pipe-B: SUCCESS (1.121s) [644.486401] Starting dynamic subtest: pipe-C [645.580497] Dynamic subtest pipe-C: SUCCESS (1.106s) [645.592805] Starting dynamic subtest: pipe-D [646.713843] Dynamic subtest pipe-D: SUCCESS (1.135s) [646.716408] Subtest planes-scaler-unity-scaling: SUCCESS (3.429s) [647.877232] [071/133] (374s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [647.984237] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [651.577294] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.604s) [652.770772] [072/133] (369s left) kms_psr (psr2-cursor-mmap-cpu) [652.875184] Starting subtest: psr2-cursor-mmap-cpu [652.877600] Starting dynamic subtest: eDP-1 [654.630943] Dynamic subtest eDP-1: SUCCESS (1.760s) [654.633527] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.761s) [655.447732] [073/133] (367s left) kms_psr (psr-sprite-plane-move) [655.544823] Starting subtest: psr-sprite-plane-move [655.547231] Starting dynamic subtest: eDP-1 [657.286103] Dynamic subtest eDP-1: SUCCESS (1.744s) [657.288655] Subtest psr-sprite-plane-move: SUCCESS (1.745s) [658.103367] [074/133] (364s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [658.212482] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [664.798089] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.594s) [664.918100] [075/133] (357s left) kms_cursor_crc (cursor-random-64x21) [665.113843] Starting subtest: cursor-random-64x21 [665.160359] Subtest cursor-random-64x21: SKIP (0.040s) [665.404800] [076/133] (357s left) perf (disabled-read-error) [665.487610] Starting subtest: disabled-read-error [665.506015] Subtest disabled-read-error: SUCCESS (0.018s) [665.553166] [077/133] (357s left) gem_wait (invalid-flags) [665.610306] Starting subtest: invalid-flags [665.612469] Subtest invalid-flags: SUCCESS (0.000s) [665.814867] [078/133] (357s left) gem_spin_batch (spin-all-new) [665.888982] Starting subtest: spin-all-new [665.905043] Subtest spin-all-new: SUCCESS (0.016s) [667.732911] [079/133] (355s left) kms_async_flips (invalid-async-flip-atomic) [667.841706] Starting subtest: invalid-async-flip-atomic [668.215438] Starting dynamic subtest: pipe-A-eDP-1 [669.067480] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.852s) [669.433206] Starting dynamic subtest: pipe-B-eDP-1 [670.193153] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.770s) [670.548470] Starting dynamic subtest: pipe-C-eDP-1 [671.319476] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.779s) [671.675487] Starting dynamic subtest: pipe-D-eDP-1 [672.445365] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.778s) [672.448257] Subtest invalid-async-flip-atomic: SUCCESS (4.608s) [673.591595] [080/133] (349s left) prime_mmap_kms (buffer-sharing) [673.704486] Starting subtest: buffer-sharing [674.158620] Subtest buffer-sharing: SUCCESS (0.454s) [675.025558] [081/133] (348s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping) [675.127566] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping [675.133231] Subtest pixel-format-4-tiled-dg2-rc-ccs-modifier-source-clamping: SKIP (0.000s) [675.203142] [082/133] (347s left) syncobj_timeline (invalid-query-illegal-handle) [675.265876] Starting subtest: invalid-query-illegal-handle [675.268782] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [675.370219] [083/133] (347s left) kms_hdr (bpc-switch) [675.469363] Starting subtest: bpc-switch [676.506384] Starting dynamic subtest: pipe-A-eDP-1 [679.993329] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.487s) [679.996269] Subtest bpc-switch: SUCCESS (4.525s) [680.097722] [084/133] (343s left) gem_exec_fence (invalid-timeline-fence-array) [680.645899] Starting subtest: invalid-timeline-fence-array [680.652863] Subtest invalid-timeline-fence-array: SUCCESS (0.007s) [681.795955] [085/133] (341s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-render) [681.896313] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-render [681.901262] Subtest fbc-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [682.001521] [086/133] (341s left) kms_prop_blob (blob-prop-core) [682.058661] Starting subtest: blob-prop-core [682.060924] Subtest blob-prop-core: SUCCESS (0.000s) [682.156513] [087/133] (341s left) fbdev (unaligned-write) [682.196375] Starting subtest: unaligned-write [682.301802] Subtest unaligned-write: SUCCESS (0.107s) [682.368613] [088/133] (341s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-plflip-blt) [682.459023] Starting subtest: psr-2p-primscrn-shrfb-plflip-blt [682.464119] Subtest psr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [682.559368] [089/133] (340s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs) [682.644801] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs [682.647082] Starting dynamic subtest: pipe-A-eDP-1 [682.709050] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [682.718256] Starting dynamic subtest: pipe-B-eDP-1 [682.786490] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [682.797224] Starting dynamic subtest: pipe-C-eDP-1 [682.865960] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [682.877486] Starting dynamic subtest: pipe-D-eDP-1 [682.945472] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [682.950254] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.009s) [684.923254] [090/133] (338s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier) [685.012289] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier [685.017330] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s) [685.083098] [091/133] (338s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb) [685.170946] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb [685.176025] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.000s) [685.240181] [092/133] (338s left) kms_pm_dc (dc5-retention-flops) [686.342242] Starting subtest: dc5-retention-flops [686.347347] Subtest dc5-retention-flops: SKIP (0.000s) [686.414297] [093/133] (337s left) kms_color (ctm-blue-to-red) [686.504594] Starting subtest: ctm-blue-to-red [686.506921] Starting dynamic subtest: pipe-A-eDP-1 [687.195303] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s) [687.204642] Starting dynamic subtest: pipe-B-eDP-1 [688.599357] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.404s) [688.609408] Starting dynamic subtest: pipe-C-eDP-1 [689.952405] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.350s) [689.962056] Starting dynamic subtest: pipe-D-eDP-1 [691.302684] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.351s) [691.305451] Subtest ctm-blue-to-red: SUCCESS (4.800s) [692.122041] [094/133] (331s left) kms_chamelium_hpd (dp-hpd-fast) [692.505357] Subtest dp-hpd-fast: SKIP (0.000s) [693.337644] [095/133] (330s left) perf_pmu (busy-start) [693.381107] Starting subtest: busy-start [693.383378] Starting dynamic subtest: rcs0 [695.932468] Dynamic subtest rcs0: SUCCESS (2.551s) [695.946318] Starting dynamic subtest: bcs0 [698.506787] Dynamic subtest bcs0: SUCCESS (2.549s) [698.519469] Starting dynamic subtest: vcs0 [701.670803] Dynamic subtest vcs0: SUCCESS (3.183s) [701.684136] Starting dynamic subtest: vcs1 [705.702916] Dynamic subtest vcs1: SUCCESS (4.030s) [705.716758] Starting dynamic subtest: vecs0 [709.671003] Dynamic subtest vecs0: SUCCESS (3.966s) [709.683909] Starting dynamic subtest: ccs0 [712.241693] Dynamic subtest ccs0: SUCCESS (2.549s) [712.244662] Subtest busy-start: SUCCESS (18.844s) [712.308699] [096/133] (311s left) kms_pm_rpm (system-suspend-idle) [713.839787] Starting subtest: system-suspend-idle [733.402342] Subtest system-suspend-idle: SUCCESS (4.356s) [733.803211] [097/133] (289s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [733.904337] Starting subtest: psr2-primary-plane-update-sf-dmg-area [733.907027] Starting dynamic subtest: pipe-A-eDP-1 [739.770286] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.865s) [739.780703] Starting dynamic subtest: pipe-B-eDP-1 [746.421687] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.646s) [746.424665] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.514s) [747.280494] [098/133] (276s left) kms_setmode (basic) [747.330642] Starting subtest: basic [747.654836] Starting dynamic subtest: pipe-A-eDP-1 [749.701139] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.042s) [750.049254] Starting dynamic subtest: pipe-B-eDP-1 [752.131110] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.086s) [752.439810] Subtest basic: SUCCESS (5.107s) [753.301335] [099/133] (270s left) kms_psr (fbc-pr-sprite-blt) [753.396816] Starting subtest: fbc-pr-sprite-blt [753.401824] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [753.470616] [100/133] (270s left) kms_flip (flip-vs-panning) [753.562877] Starting subtest: flip-vs-panning [753.565824] Starting dynamic subtest: A-eDP1 [762.292745] Dynamic subtest A-eDP1: SUCCESS (8.729s) [762.303496] Starting dynamic subtest: B-eDP1 [771.030578] Dynamic subtest B-eDP1: SUCCESS (8.735s) [771.040472] Starting dynamic subtest: C-eDP1 [779.731758] Dynamic subtest C-eDP1: SUCCESS (8.700s) [779.748475] Starting dynamic subtest: D-eDP1 [788.469127] Dynamic subtest D-eDP1: SUCCESS (8.736s) [788.473401] Subtest flip-vs-panning: SUCCESS (34.912s) [789.632555] [101/133] (234s left) kms_vblank (ts-continuation-modeset) [789.732563] Starting subtest: ts-continuation-modeset [789.734791] Starting dynamic subtest: pipe-A-eDP-1 [791.186291] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.455s) [791.201356] Starting dynamic subtest: pipe-D-eDP-1 [793.362708] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.172s) [793.365088] Subtest ts-continuation-modeset: SUCCESS (3.631s) [794.157620] [102/133] (229s left) kms_pipe_b_c_ivb (from-pipe-c-to-b-with-3-lanes) [794.222817] Subtest from-pipe-C-to-B-with-3-lanes: SKIP (0.000s) [794.280965] [103/133] (229s left) kms_async_flips (async-flip-hang) [794.378809] Starting subtest: async-flip-hang [794.755145] Starting dynamic subtest: pipe-A-eDP-1 [810.356240] Dynamic subtest pipe-A-eDP-1: SUCCESS (15.591s) [810.729850] Starting dynamic subtest: pipe-B-eDP-1 [826.338857] Dynamic subtest pipe-B-eDP-1: SUCCESS (15.615s) [826.721626] Starting dynamic subtest: pipe-C-eDP-1 [842.348868] Dynamic subtest pipe-C-eDP-1: SUCCESS (15.621s) [842.713093] Starting dynamic subtest: pipe-D-eDP-1 [858.340875] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.636s) [858.343884] Subtest async-flip-hang: SUCCESS (63.962s) [859.505923] [104/133] (164s left) gem_exec_balancer (bonded-semaphore) [859.572388] Starting subtest: bonded-semaphore [859.577481] Subtest bonded-semaphore: SKIP (0.000s) [859.856331] [105/133] (164s left) gem_userptr_blits (sync-overlap) [859.918663] Starting subtest: sync-overlap [859.921490] Subtest sync-overlap: SUCCESS (0.000s) [860.039381] [106/133] (164s left) kms_flip (2x-flip-vs-modeset) [860.120085] Starting subtest: 2x-flip-vs-modeset [860.130821] Subtest 2x-flip-vs-modeset: SKIP (0.010s) [860.207432] [107/133] (164s left) kms_busy (extended-pageflip-modeset-hang-oldfb) [860.306018] Starting subtest: extended-pageflip-modeset-hang-oldfb [860.308717] Starting dynamic subtest: pipe-A [868.196839] Dynamic subtest pipe-A: SUCCESS (7.888s) [868.208747] Starting dynamic subtest: pipe-D [876.826074] Dynamic subtest pipe-D: SUCCESS (8.631s) [876.828764] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.524s) [877.684210] [108/133] (146s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [877.785967] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [877.788189] Starting dynamic subtest: pipe-A-eDP-1 [877.811067] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [877.821624] Starting dynamic subtest: pipe-B-eDP-1 [877.846550] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [877.856597] Starting dynamic subtest: pipe-C-eDP-1 [877.883803] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [877.894441] Starting dynamic subtest: pipe-D-eDP-1 [877.920596] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [877.925584] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SKIP (0.007s) [880.043790] [109/133] (144s left) kms_vblank (query-busy) [880.131977] Starting subtest: query-busy [880.134664] Starting dynamic subtest: pipe-A-eDP-1 [882.006762] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.878s) [882.025801] Starting dynamic subtest: pipe-D-eDP-1 [884.603596] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.592s) [884.605839] Subtest query-busy: SUCCESS (4.473s) [885.417696] [110/133] (138s left) syncobj_timeline (wait-all-snapshot) [885.475850] Starting subtest: wait-all-snapshot [885.557844] Subtest wait-all-snapshot: SUCCESS (0.083s) [885.640106] [111/133] (138s left) kms_cursor_legacy (cursora-vs-flipb-atomic) [885.753273] Starting subtest: cursorA-vs-flipB-atomic [885.757944] Subtest cursorA-vs-flipB-atomic: SKIP (0.001s) [885.916015] [112/133] (138s left) gem_ctx_persistence (legacy-engines-queued) [885.979666] Starting subtest: legacy-engines-queued [885.982388] Starting dynamic subtest: render [886.065992] Dynamic subtest render: SUCCESS (0.086s) [886.076800] Starting dynamic subtest: bsd1 [887.850556] Dynamic subtest bsd1: SUCCESS (1.781s) [887.862830] Starting dynamic subtest: bsd2 [889.834602] Dynamic subtest bsd2: SUCCESS (1.982s) [889.847646] Starting dynamic subtest: blt [889.869969] Dynamic subtest blt: SUCCESS (0.034s) [889.879980] Starting dynamic subtest: vebox [891.819216] Dynamic subtest vebox: SUCCESS (1.946s) [891.822263] Subtest legacy-engines-queued: SUCCESS (5.841s) [891.909386] [113/133] (132s left) gem_ctx_bad_destroy (double-destroy) [891.972541] Starting subtest: double-destroy [891.975301] Subtest double-destroy: SUCCESS (0.000s) [892.057138] [114/133] (132s left) gem_mmap_wc (read-write-distinct) [892.116619] Subtest read-write-distinct: SKIP (0.000s) [892.195798] [115/133] (132s left) kms_draw_crc (draw-method-pwrite) [892.294576] Starting subtest: draw-method-pwrite [892.297198] Starting dynamic subtest: xrgb8888-untiled [892.870723] Dynamic subtest xrgb8888-untiled: SUCCESS (0.578s) [892.881280] Starting dynamic subtest: rgb565-untiled [893.304331] Dynamic subtest rgb565-untiled: SUCCESS (0.433s) [893.315005] Starting dynamic subtest: xrgb2101010-untiled [893.837386] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.532s) [893.847630] Starting dynamic subtest: xbgr16161616f-untiled [894.570489] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.732s) [894.580621] Starting dynamic subtest: xrgb8888-xtiled [896.304321] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.732s) [896.314841] Starting dynamic subtest: rgb565-xtiled [897.350816] Dynamic subtest rgb565-xtiled: SUCCESS (1.043s) [897.366236] Starting dynamic subtest: xrgb2101010-xtiled [899.059362] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.710s) [899.069807] Starting dynamic subtest: xbgr16161616f-xtiled [902.538721] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.477s) [902.548862] Starting dynamic subtest: xrgb8888-4tiled [903.615589] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.075s) [903.625902] Starting dynamic subtest: rgb565-4tiled [904.170843] Dynamic subtest rgb565-4tiled: SUCCESS (0.553s) [904.180848] Starting dynamic subtest: xrgb2101010-4tiled [905.248568] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.077s) [905.258515] Starting dynamic subtest: xbgr16161616f-4tiled [908.248406] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.998s) [908.251106] Subtest draw-method-pwrite: SUCCESS (15.957s) [908.344149] [116/133] (116s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [908.449594] Starting subtest: fbc-indfb-scaledprimary [911.396090] Subtest fbc-indfb-scaledprimary: SUCCESS (2.951s) [912.560647] [117/133] (112s left) gem_exec_schedule (u-submit-early-slice) [912.638026] Starting subtest: u-submit-early-slice [912.640299] Starting dynamic subtest: rcs0 [912.668631] Dynamic subtest rcs0: SUCCESS (0.042s) [912.680931] Starting dynamic subtest: bcs0 [912.708743] Dynamic subtest bcs0: SUCCESS (0.039s) [912.719499] Starting dynamic subtest: vcs0 [912.748767] Dynamic subtest vcs0: SUCCESS (0.039s) [912.763806] Starting dynamic subtest: vcs1 [912.793046] Dynamic subtest vcs1: SUCCESS (0.044s) [912.804367] Starting dynamic subtest: vecs0 [912.823827] Dynamic subtest vecs0: SUCCESS (0.030s) [912.833685] Starting dynamic subtest: ccs0 [912.860815] Dynamic subtest ccs0: SUCCESS (0.036s) [912.863670] Subtest u-submit-early-slice: SUCCESS (0.235s) [913.948247] [118/133] (110s left) gem_mmap_gtt (cpuset-basic-small-copy-odd) [914.002651] Subtest cpuset-basic-small-copy-odd: SKIP (0.000s) [914.063128] [119/133] (110s left) gem_exec_whisper (basic-queues-priority-all) [914.130533] Starting subtest: basic-queues-priority-all [936.297546] Subtest basic-queues-priority-all: SUCCESS (22.163s) [936.479696] [120/133] ( 88s left) kms_frontbuffer_tracking (psr-indfb-scaledprimary) [936.596562] Starting subtest: psr-indfb-scaledprimary [942.402496] Subtest psr-indfb-scaledprimary: SUCCESS (5.808s) [942.551131] [121/133] ( 82s left) gem_exec_reloc (basic-active) [942.610385] Subtest basic-active: SKIP (0.000s) [942.688654] [122/133] ( 82s left) kms_rotation_crc (primary-rotation-90) [942.773165] Starting subtest: primary-rotation-90 [942.778700] Subtest primary-rotation-90: SKIP (0.001s) [942.847173] [123/133] ( 82s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [942.966817] Starting subtest: short-flip-before-cursor-atomic-transitions [943.954791] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.986s) [944.804196] [124/133] ( 80s left) sysfs_preempt_timeout (invalid) [944.867357] Starting subtest: invalid [944.870089] Starting dynamic subtest: vecs0 [944.872831] Dynamic subtest vecs0: SUCCESS (0.000s) [944.884861] Starting dynamic subtest: ccs0 [944.887630] Dynamic subtest ccs0: SUCCESS (0.000s) [944.898079] Starting dynamic subtest: vcs0 [944.900755] Dynamic subtest vcs0: SUCCESS (0.000s) [944.911843] Starting dynamic subtest: bcs0 [944.914682] Dynamic subtest bcs0: SUCCESS (0.000s) [944.924810] Starting dynamic subtest: rcs0 [944.927607] Dynamic subtest rcs0: SUCCESS (0.000s) [944.937168] Starting dynamic subtest: vcs1 [944.939840] Dynamic subtest vcs1: SUCCESS (0.000s) [944.942596] Subtest invalid: SUCCESS (0.006s) [944.984486] [125/133] ( 80s left) kms_big_fb (4-tiled-16bpp-rotate-270) [945.080742] Starting subtest: 4-tiled-16bpp-rotate-270 [945.101254] Subtest 4-tiled-16bpp-rotate-270: SKIP (0.020s) [945.202936] [126/133] ( 79s left) kms_dp_aux_dev [945.564682] [127/133] ( 79s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [945.666327] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [945.671352] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [945.772473] [128/133] ( 79s left) kms_chamelium_audio (dp-audio) [946.174751] Subtest dp-audio: SKIP (0.000s) [947.012104] [129/133] ( 78s left) dmabuf_sync_file (export-basic) [947.061223] Starting subtest: export-basic [947.063838] Subtest export-basic: SUCCESS (0.001s) [947.122684] [130/133] ( 78s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-plflip-blt) [947.233430] Starting subtest: fbcpsr-2p-scndscrn-indfb-plflip-blt [947.238608] Subtest fbcpsr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [947.336283] [131/133] ( 77s left) gem_sync (basic-store-each) [947.413519] Starting subtest: basic-store-each [949.867074] Subtest basic-store-each: SUCCESS (2.468s) [950.059464] [132/133] ( 75s left) i915_drm_fdinfo (virtual-busy-hang-all) [950.103720] Starting subtest: virtual-busy-hang-all [950.109821] Subtest virtual-busy-hang-all: SKIP (0.000s) [950.178919] [133/133] ( 75s left) gem_ctx_param (invalid-set-ringsize) [950.226990] Starting subtest: invalid-set-ringsize [950.229672] Subtest invalid-set-ringsize: SUCCESS (0.000s) [950.310816] 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.