[58.002265] Initializing watchdogs [58.002313] /dev/watchdog0 [58.015329] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [58.019664] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.021854] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.025511] [001/130] (960s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [58.199325] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [58.203739] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [58.296630] [002/130] (960s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [58.395921] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [58.398309] Starting dynamic subtest: pipe-A-eDP-1 [58.418804] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [58.426759] Starting dynamic subtest: pipe-B-eDP-1 [58.446347] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [58.452172] Starting dynamic subtest: pipe-C-eDP-1 [58.471172] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [58.476807] Starting dynamic subtest: pipe-D-eDP-1 [58.496195] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [58.498080] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.003s) [60.543185] [003/130] (958s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-onoff) [60.650443] Starting subtest: psr-2p-primscrn-spr-indfb-onoff [60.654708] Subtest psr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [60.727346] [004/130] (957s left) gem_fenced_exec_thrash (2-spare-fences) [60.779736] Subtest 2-spare-fences: SKIP (0.000s) [60.856436] [005/130] (957s left) i915_pciid [61.021538] [006/130] (957s left) kms_joiner (basic-force-ultra-joiner) [61.123153] Starting subtest: basic-force-ultra-joiner [61.127608] Subtest basic-force-ultra-joiner: SKIP (0.000s) [61.180127] [007/130] (957s left) gem_mmap_gtt (basic-read-write-distinct) [61.233239] Subtest basic-read-write-distinct: SKIP (0.000s) [61.289727] [008/130] (957s left) prime_vgem (fence-write-hang) [61.397355] Subtest fence-write-hang: SKIP (0.000s) [61.488762] [FACT prime_vgem (fence-write-hang)] new: kernel.kmod_is_loaded.vgem: true [61.492231] [009/130] (957s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [61.596687] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [61.598825] Starting dynamic subtest: pipe-A-eDP-1 [61.805903] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.195s) [61.813445] Starting dynamic subtest: pipe-B-eDP-1 [61.832949] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [61.839345] Starting dynamic subtest: pipe-C-eDP-1 [61.859589] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s) [61.866007] Starting dynamic subtest: pipe-D-eDP-1 [61.887950] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [61.890435] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.202s) [64.034659] [010/130] (954s left) kms_cursor_legacy (2x-long-flip-vs-cursor-atomic) [64.153498] Starting subtest: 2x-long-flip-vs-cursor-atomic [64.158202] Subtest 2x-long-flip-vs-cursor-atomic: SKIP (0.001s) [64.253219] [011/130] (954s left) syncobj_wait (multi-wait-for-submit-unsubmitted-signaled) [64.319665] Starting subtest: multi-wait-for-submit-unsubmitted-signaled [64.322165] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s) [64.428076] [012/130] (954s left) gem_sync (basic-store-each) [64.510185] Starting subtest: basic-store-each [66.993138] Subtest basic-store-each: SUCCESS (2.478s) [67.168113] [013/130] (951s left) gen7_exec_parse (cmd-crossing-page) [67.217911] Subtest cmd-crossing-page: SKIP (0.000s) [67.296926] [014/130] (951s left) kms_pipe_crc_basic (nonblocking-crc) [67.401077] Starting subtest: nonblocking-crc [67.403363] Starting dynamic subtest: pipe-A-eDP-1 [68.152609] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.747s) [68.160547] Starting dynamic subtest: pipe-B-eDP-1 [69.544510] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.384s) [69.550277] Starting dynamic subtest: pipe-C-eDP-1 [70.859220] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.310s) [70.867066] Starting dynamic subtest: pipe-D-eDP-1 [72.164915] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.302s) [72.167342] Subtest nonblocking-crc: SUCCESS (4.748s) [72.978954] [015/130] (946s left) gem_exec_reloc (basic-write-gtt-active) [73.052089] Subtest basic-write-gtt-active: SKIP (0.000s) [73.123877] [016/130] (945s left) kms_flip (dpms-off-confusion) [73.225215] Starting subtest: dpms-off-confusion [73.227575] Starting dynamic subtest: A-eDP1 [81.926506] Dynamic subtest A-eDP1: SUCCESS (8.657s) [81.935544] Starting dynamic subtest: B-eDP1 [90.627903] Dynamic subtest B-eDP1: SUCCESS (8.729s) [90.635148] Starting dynamic subtest: C-eDP1 [99.392940] Dynamic subtest C-eDP1: SUCCESS (8.715s) [99.401723] Starting dynamic subtest: D-eDP1 [107.980939] Dynamic subtest D-eDP1: SUCCESS (8.630s) [107.985604] Subtest dpms-off-confusion: SUCCESS (34.739s) [109.146211] [017/130] (910s left) kms_dp_link_training (uhbr-sst) [109.245921] Starting subtest: uhbr-sst [109.254728] Subtest uhbr-sst: SKIP (0.000s) [109.309327] [018/130] (909s left) gem_pxp (verify-pxp-stale-ctx-execution) [109.433451] Starting subtest: verify-pxp-stale-ctx-execution [110.495401] Subtest verify-pxp-stale-ctx-execution: SUCCESS (1.060s) [110.629626] [019/130] (908s left) kms_lease (lease-get) [110.720539] Starting subtest: lease-get [110.723357] Starting dynamic subtest: pipe-A-eDP-1 [110.725838] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [110.733803] Starting dynamic subtest: pipe-B-eDP-1 [110.735996] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [110.742281] Starting dynamic subtest: pipe-C-eDP-1 [110.744484] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [110.750852] Starting dynamic subtest: pipe-D-eDP-1 [110.753081] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [110.755212] Subtest lease-get: SUCCESS (0.006s) [110.820338] [020/130] (908s left) kms_psr (fbc-psr2-dpms) [110.915751] Starting subtest: fbc-psr2-dpms [110.918175] Starting dynamic subtest: eDP-1 [110.922511] Dynamic subtest eDP-1: SKIP (0.000s) [110.926821] Subtest fbc-psr2-dpms: SKIP (0.000s) [110.981615] [021/130] (908s left) kms_sequence (queue-idle) [111.073883] Starting subtest: queue-idle [111.076261] Starting dynamic subtest: pipe-A-eDP-1 [112.887203] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.809s) [112.895401] Starting dynamic subtest: pipe-B-eDP-1 [115.301947] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.413s) [115.309859] Starting dynamic subtest: pipe-C-eDP-1 [117.718878] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.418s) [117.727278] Starting dynamic subtest: pipe-D-eDP-1 [120.150837] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.431s) [120.153435] Subtest queue-idle: SUCCESS (9.075s) [120.945998] [022/130] (898s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [121.049015] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [121.053388] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [121.146579] [023/130] (898s left) gem_softpin (allocator-evict) [121.204499] Starting subtest: allocator-evict [121.206738] Starting dynamic subtest: rcs0 [146.432706] Dynamic subtest rcs0: SUCCESS (25.223s) [146.440611] Starting dynamic subtest: bcs0 [172.507853] Dynamic subtest bcs0: SUCCESS (26.071s) [172.515180] Starting dynamic subtest: vcs0 [198.179712] Dynamic subtest vcs0: SUCCESS (25.669s) [198.187564] Starting dynamic subtest: vcs1 [224.102806] Dynamic subtest vcs1: SUCCESS (25.919s) [224.112874] Starting dynamic subtest: vecs0 [250.090992] Dynamic subtest vecs0: SUCCESS (25.985s) [250.099846] Starting dynamic subtest: ccs0 [276.207552] Dynamic subtest ccs0: SUCCESS (26.114s) [276.210072] Subtest allocator-evict: SUCCESS (154.985s) [276.284366] [024/130] (743s left) kms_getfb (getfb-handle-protection) [276.392046] Starting subtest: getfb-handle-protection [276.418673] Subtest getfb-handle-protection: SUCCESS (0.028s) [276.552195] [025/130] (742s left) gem_eio (create) [276.815104] Starting subtest: create [277.155827] Subtest create: SUCCESS (0.338s) [277.268390] [026/130] (742s left) kms_content_protection (srm) [277.457177] Starting subtest: srm [280.693734] Subtest srm: SKIP (3.235s) [281.863049] [027/130] (737s left) gem_exec_schedule (submit-golden-slice) [281.960187] Starting subtest: submit-golden-slice [281.962420] Starting dynamic subtest: rcs0 [281.986511] Dynamic subtest rcs0: SUCCESS (0.033s) [281.997526] Starting dynamic subtest: bcs0 [282.022962] Dynamic subtest bcs0: SUCCESS (0.036s) [282.035946] Starting dynamic subtest: vcs0 [282.056758] Dynamic subtest vcs0: SUCCESS (0.034s) [282.063994] Starting dynamic subtest: vcs1 [282.084630] Dynamic subtest vcs1: SUCCESS (0.028s) [282.091803] Starting dynamic subtest: vecs0 [282.121105] Dynamic subtest vecs0: SUCCESS (0.036s) [282.128099] Starting dynamic subtest: ccs0 [282.161288] Dynamic subtest ccs0: SUCCESS (0.039s) [282.163725] Subtest submit-golden-slice: SUCCESS (0.208s) [284.043440] [028/130] (735s left) gem_pwrite_snooped [284.161623] [029/130] (735s left) gem_ctx_bad_destroy (invalid-ctx) [284.207625] Starting subtest: invalid-ctx [284.209907] Subtest invalid-ctx: SUCCESS (0.000s) [284.273835] [030/130] (735s left) kms_vrr (seamless-rr-switch-virtual) [284.373895] Starting subtest: seamless-rr-switch-virtual [284.380533] Subtest seamless-rr-switch-virtual: SKIP (0.000s) [284.441590] [031/130] (735s left) kms_prop_blob (invalid-get-prop-any) [284.497112] Starting subtest: invalid-get-prop-any [284.499538] Subtest invalid-get-prop-any: SUCCESS (0.000s) [284.598375] [032/130] (735s left) gem_sync (basic-all) [284.680741] Starting subtest: basic-all [288.213985] Subtest basic-all: SUCCESS (3.544s) [288.395194] [033/130] (731s left) gem_ctx_persistence (saturated-hostile-nopreempt) [288.460682] Starting subtest: saturated-hostile-nopreempt [288.462845] Starting dynamic subtest: rcs0 [288.515686] Dynamic subtest rcs0: SKIP (0.053s) [288.522800] Starting dynamic subtest: bcs0 [288.549583] Dynamic subtest bcs0: SKIP (0.034s) [288.556696] Starting dynamic subtest: vcs0 [288.571561] Dynamic subtest vcs0: SKIP (0.022s) [288.578504] Starting dynamic subtest: vcs1 [288.587334] Dynamic subtest vcs1: SKIP (0.016s) [288.593941] Starting dynamic subtest: vecs0 [288.598161] Dynamic subtest vecs0: SKIP (0.009s) [288.605026] Starting dynamic subtest: ccs0 [288.615492] Dynamic subtest ccs0: SKIP (0.019s) [288.619859] Subtest saturated-hostile-nopreempt: SKIP (0.153s) [288.683206] [034/130] (731s left) syncobj_wait (wait-all-complex) [288.739966] Starting subtest: wait-all-complex [288.954623] Subtest wait-all-complex: SUCCESS (0.213s) [289.025396] [035/130] (730s left) kms_psr (fbc-pr-sprite-mmap-cpu) [289.123919] Starting subtest: fbc-pr-sprite-mmap-cpu [289.128562] Subtest fbc-pr-sprite-mmap-cpu: SKIP (0.000s) [289.193451] [036/130] (730s left) kms_psr (psr2-sprite-plane-move) [289.286353] Starting subtest: psr2-sprite-plane-move [289.288708] Starting dynamic subtest: eDP-1 [291.085250] Dynamic subtest eDP-1: SUCCESS (1.796s) [291.087643] Subtest psr2-sprite-plane-move: SUCCESS (1.797s) [291.914340] [037/130] (727s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [292.018699] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [292.023263] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [292.098026] [038/130] (727s left) kms_plane_scaling (planes-downscale-factor-0-25-upscale-factor-0-25) [292.207911] Starting subtest: planes-downscale-factor-0-25-upscale-factor-0-25 [292.210432] Starting dynamic subtest: pipe-A [292.226051] Dynamic subtest pipe-A: SKIP (0.012s) [292.234779] Starting dynamic subtest: pipe-B [292.246548] Dynamic subtest pipe-B: SKIP (0.020s) [292.254326] Starting dynamic subtest: pipe-C [292.266764] Dynamic subtest pipe-C: SKIP (0.020s) [292.274291] Starting dynamic subtest: pipe-D [292.285853] Dynamic subtest pipe-D: SKIP (0.021s) [292.290294] Subtest planes-downscale-factor-0-25-upscale-factor-0-25: SKIP (0.073s) [292.364568] [039/130] (727s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [292.425014] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [292.535509] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.109s) [292.603221] [040/130] (727s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-mc-ccs) [292.699141] Starting subtest: crc-primary-suspend-4-tiled-mtl-mc-ccs [292.701320] Starting dynamic subtest: pipe-A-eDP-1 [324.266144] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.953s) [324.275192] Starting dynamic subtest: pipe-B-eDP-1 [357.160334] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.390s) [357.170865] Starting dynamic subtest: pipe-C-eDP-1 [390.141347] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.484s) [390.150245] Starting dynamic subtest: pipe-D-eDP-1 [423.147947] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.394s) [423.150379] Subtest crc-primary-suspend-4-tiled-mtl-mc-ccs: SUCCESS (13.224s) [424.385811] [041/130] (712s left) gem_exec_whisper (basic-queues-forked-all) [424.450443] Starting subtest: basic-queues-forked-all [442.152467] Subtest basic-queues-forked-all: SUCCESS (17.466s) [442.330760] [042/130] (695s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt) [442.436878] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt [442.440957] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [442.540056] [043/130] (695s left) kms_plane_scaling (plane-downscale-factor-0-5-with-pixel-format) [442.647246] Starting subtest: plane-downscale-factor-0-5-with-pixel-format [442.649481] Starting dynamic subtest: pipe-A [442.658424] Dynamic subtest pipe-A: SKIP (0.004s) [442.668367] Starting dynamic subtest: pipe-B [442.677598] Dynamic subtest pipe-B: SKIP (0.014s) [442.686466] Starting dynamic subtest: pipe-C [442.695821] Dynamic subtest pipe-C: SKIP (0.014s) [442.704557] Starting dynamic subtest: pipe-D [442.712585] Dynamic subtest pipe-D: SKIP (0.015s) [442.717406] Subtest plane-downscale-factor-0-5-with-pixel-format: SKIP (0.049s) [442.814387] [044/130] (694s left) syncobj_wait (wait-all-for-submit-delayed-submit) [442.865039] Starting subtest: wait-all-for-submit-delayed-submit [442.966597] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.102s) [443.040218] [045/130] (694s left) gem_ctx_engines (invalid-engines) [443.097044] Starting subtest: invalid-engines [443.107067] Subtest invalid-engines: SUCCESS (0.010s) [443.347900] [046/130] (694s left) gem_exec_schedule (implicit-write-read) [443.433101] Starting subtest: implicit-write-read [443.435541] Starting dynamic subtest: rcs0 [443.531094] Dynamic subtest rcs0: SUCCESS (0.105s) [443.542462] Starting dynamic subtest: vcs0 [443.608828] Dynamic subtest vcs0: SUCCESS (0.078s) [443.621261] Starting dynamic subtest: vcs1 [443.681826] Dynamic subtest vcs1: SUCCESS (0.072s) [443.693509] Starting dynamic subtest: vecs0 [443.758234] Dynamic subtest vecs0: SUCCESS (0.076s) [443.771333] Starting dynamic subtest: ccs0 [443.836363] Dynamic subtest ccs0: SUCCESS (0.078s) [443.838870] Subtest implicit-write-read: SUCCESS (0.411s) [444.880729] [047/130] (692s left) gem_exec_flush (basic-uc-pro-default) [444.943661] Starting subtest: basic-uc-pro-default [450.442911] Subtest basic-uc-pro-default: SUCCESS (5.486s) [450.623542] [048/130] (687s left) kms_psr (pr-primary-mmap-gtt) [450.726048] Starting subtest: pr-primary-mmap-gtt [450.730572] Subtest pr-primary-mmap-gtt: SKIP (0.000s) [450.797593] [049/130] (687s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [450.894571] Starting subtest: x-tiled-addfb-size-offset-overflow [450.896918] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [450.981060] [050/130] (686s left) perf_pmu (busy-idle-check-all) [451.028678] Starting subtest: busy-idle-check-all [451.031194] Starting dynamic subtest: rcs0 [451.707620] Dynamic subtest rcs0: SUCCESS (0.679s) [451.719494] Starting dynamic subtest: bcs0 [452.359124] Dynamic subtest bcs0: SUCCESS (0.650s) [452.370796] Starting dynamic subtest: vcs0 [453.800947] Dynamic subtest vcs0: SUCCESS (1.436s) [453.812185] Starting dynamic subtest: vcs1 [455.783953] Dynamic subtest vcs1: SUCCESS (1.983s) [455.796409] Starting dynamic subtest: vecs0 [457.768287] Dynamic subtest vecs0: SUCCESS (1.983s) [457.780798] Starting dynamic subtest: ccs0 [458.423224] Dynamic subtest ccs0: SUCCESS (0.655s) [458.425784] Subtest busy-idle-check-all: SUCCESS (7.395s) [458.508894] [051/130] (679s left) kms_pm_dc (dc3co-vpb-simulation) [459.628893] Starting subtest: dc3co-vpb-simulation [468.823673] Subtest dc3co-vpb-simulation: SKIP (9.140s) [468.920643] [052/130] (668s left) kms_flip (2x-busy-flip) [469.027962] Starting subtest: 2x-busy-flip [469.038352] Subtest 2x-busy-flip: SKIP (0.010s) [469.117626] [053/130] (668s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-downscaling) [469.211820] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-downscaling [469.214117] Starting dynamic subtest: pipe-A-default-mode [469.500871] Dynamic subtest pipe-A-default-mode: SKIP (0.284s) [469.505322] Subtest flip-32bpp-ytile-to-64bpp-ytile-downscaling: SKIP (0.286s) [470.361010] [054/130] (667s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [470.424220] Starting subtest: multi-wait-available-unsubmitted-submitted [470.426563] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [470.533836] [055/130] (667s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [470.645068] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [471.758474] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.112s) [471.952559] [056/130] (666s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt) [472.067158] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt [472.071613] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [472.182338] [057/130] (665s left) gem_eio (in-flight-internal-immediate) [472.396190] Starting subtest: in-flight-internal-immediate [473.825540] Subtest in-flight-internal-immediate: SUCCESS (1.430s) [473.975218] [058/130] (664s left) gem_ppgtt (blt-vs-render-ctx0) [474.039265] Starting subtest: blt-vs-render-ctx0 [506.966859] Subtest blt-vs-render-ctx0: SUCCESS (32.917s) [507.102013] [059/130] (631s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [507.262109] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [512.169995] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (4.907s) [512.313653] [060/130] (625s left) gem_exec_gttfill (multigpu-basic) [512.483773] Starting subtest: multigpu-basic [528.747180] Subtest multigpu-basic: SUCCESS (16.265s) [528.798181] [061/130] (609s left) gem_mmap_gtt (basic) [528.899654] Subtest basic: SKIP (0.000s) [528.960933] [062/130] (609s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [529.070368] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [529.082571] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.010s) [529.170853] [063/130] (609s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [529.275021] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [529.279380] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [529.385452] [064/130] (608s left) sw_sync (sync_busy_fork_unixsocket) [529.427688] Starting subtest: sync_busy_fork_unixsocket [529.438494] Subtest sync_busy_fork_unixsocket: SUCCESS (0.011s) [529.493559] [065/130] (608s left) gen9_exec_parse (basic-rejected) [529.557191] Subtest basic-rejected: SKIP (0.000s) [529.623284] [066/130] (608s left) syncobj_timeline (single-wait-all-available-submitted) [529.680951] Starting subtest: single-wait-all-available-submitted [529.683106] Subtest single-wait-all-available-submitted: SUCCESS (0.000s) [529.789388] [067/130] (608s left) gem_exec_schedule (preempt-queue-contexts-chain) [529.850583] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [530.142500] [068/130] (608s left) i915_suspend (basic-s2idle-without-i915) [530.181400] Starting subtest: basic-s2idle-without-i915 [551.420313] Subtest basic-s2idle-without-i915: SUCCESS (5.768s) [551.555621] [069/130] (602s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [551.653025] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [551.655418] Starting dynamic subtest: pipe-A-eDP-1 [552.419272] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.731s) [552.428740] Starting dynamic subtest: pipe-B-eDP-1 [554.232004] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.762s) [554.240210] Starting dynamic subtest: pipe-C-eDP-1 [556.096765] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.823s) [556.106875] Starting dynamic subtest: pipe-D-eDP-1 [558.169305] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.037s) [558.171209] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.358s) [559.303027] [070/130] (594s left) kms_chamelium_color (ctm-blue-to-red) [559.404548] Subtest ctm-blue-to-red: SKIP (0.000s) [559.457197] [071/130] (594s left) kms_cursor_legacy (2x-long-nonblocking-modeset-vs-cursor-atomic) [559.579755] Starting subtest: 2x-long-nonblocking-modeset-vs-cursor-atomic [559.583866] Subtest 2x-long-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s) [559.707545] [072/130] (594s left) gem_ppgtt (shrink-vs-evict-pinned) [559.782196] Starting subtest: shrink-vs-evict-pinned [565.257019] Subtest shrink-vs-evict-pinned: SUCCESS (5.374s) [565.291171] [073/130] (589s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-render) [565.401207] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-render [570.188672] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-render: SUCCESS (4.768s) [570.331443] [074/130] (584s left) gem_mmap_gtt (big-bo) [570.394325] Subtest big-bo: SKIP (0.000s) [570.456435] [075/130] (584s left) api_intel_bb (reset-flags) [570.516814] Starting subtest: reset-flags [570.523101] Subtest reset-flags: SUCCESS (0.009s) [570.656366] [076/130] (583s left) kms_psr (psr-no-drrs) [570.767180] Starting subtest: psr-no-drrs [570.769474] Starting dynamic subtest: eDP-1 [572.414327] Dynamic subtest eDP-1: SUCCESS (1.640s) [572.416729] Subtest psr-no-drrs: SUCCESS (1.641s) [573.281635] [077/130] (581s left) gem_set_tiling_vs_blt (tiled-to-untiled) [573.351584] Subtest tiled-to-untiled: SKIP (0.000s) [573.404415] [078/130] (581s left) core_setmaster_vs_auth [573.560850] [079/130] (581s left) syncobj_wait (multi-wait-all-signaled) [573.621740] Starting subtest: multi-wait-all-signaled [573.624187] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [573.724213] [080/130] (580s left) kms_atomic (atomic-plane-damage) [573.823196] Starting subtest: atomic-plane-damage [573.900636] Starting dynamic subtest: pipe-A-eDP-1 [574.513408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.608s) [574.515470] Subtest atomic-plane-damage: SUCCESS (0.686s) [575.312651] [081/130] (579s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip) [575.424247] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip [575.428751] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip: SKIP (0.000s) [575.519142] [082/130] (579s left) kms_big_fb (y-tiled-8bpp-rotate-90) [575.627530] Starting subtest: y-tiled-8bpp-rotate-90 [575.631958] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s) [575.714341] [083/130] (579s left) kms_vblank (query-forked-busy-hang) [575.815157] Starting subtest: query-forked-busy-hang [575.817436] Starting dynamic subtest: pipe-A-eDP-1 [601.971919] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.141s) [601.985768] Starting dynamic subtest: pipe-D-eDP-1 [617.007279] Dynamic subtest pipe-D-eDP-1: SUCCESS (15.027s) [617.009655] Subtest query-forked-busy-hang: SUCCESS (41.172s) [617.876028] [084/130] (536s left) fbdev (unaligned-read) [617.923026] Starting subtest: unaligned-read [617.938827] Subtest unaligned-read: SUCCESS (0.016s) [617.989234] [085/130] (536s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions) [618.093489] Starting subtest: short-flip-before-cursor-atomic-transitions [619.063111] Subtest short-flip-before-cursor-atomic-transitions: SUCCESS (0.965s) [619.900795] [086/130] (534s left) gem_userptr_blits (stress-mm-invalidate-close) [619.973341] Starting subtest: stress-mm-invalidate-close [622.176975] Subtest stress-mm-invalidate-close: SUCCESS (2.148s) [622.243105] [087/130] (532s left) kms_pm_rpm (modeset-non-lpsp-stress) [624.389273] Starting subtest: modeset-non-lpsp-stress [625.540568] Subtest modeset-non-lpsp-stress: SKIP (1.148s) [625.890813] [088/130] (529s left) gem_fence_thrash (bo-copy) [625.927565] Starting subtest: bo-copy [625.959569] Subtest bo-copy: SKIP (0.028s) [626.018669] [089/130] (528s left) kms_cursor_crc (cursor-random-256x256) [626.221955] Starting subtest: cursor-random-256x256 [626.227152] Starting dynamic subtest: pipe-A-eDP-1 [629.812500] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.584s) [629.837439] Starting dynamic subtest: pipe-D-eDP-1 [634.064024] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.233s) [634.066496] Subtest cursor-random-256x256: SUCCESS (7.838s) [634.933213] [090/130] (520s left) kms_chamelium_hpd (vga-hpd-with-enabled-mode) [635.314931] Subtest vga-hpd-with-enabled-mode: SKIP (0.000s) [636.139028] [091/130] (518s left) gem_mmap (bad-size) [636.206027] Subtest bad-size: SKIP (0.000s) [636.255374] [092/130] (518s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [636.366545] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [636.378547] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [636.486445] [093/130] (518s left) syncobj_timeline (single-wait-for-submit-available-submitted) [636.543185] Starting subtest: single-wait-for-submit-available-submitted [636.545441] Subtest single-wait-for-submit-available-submitted: SUCCESS (0.000s) [636.652484] [094/130] (518s left) gem_ctx_param (vm) [636.702614] Starting subtest: vm [636.745713] Subtest vm: SUCCESS (0.043s) [636.875573] [095/130] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-render) [636.985185] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-render [636.989253] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [637.079574] [096/130] (518s left) kms_big_fb (yf-tiled-16bpp-rotate-90) [637.172612] Starting subtest: yf-tiled-16bpp-rotate-90 [637.176422] Subtest yf-tiled-16bpp-rotate-90: SKIP (0.000s) [637.254047] [097/130] (518s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf) [642.209411] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf [642.211690] Starting dynamic subtest: pipe-A-eDP-1 [659.383618] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.176s) [659.393667] Starting dynamic subtest: pipe-B-eDP-1 [676.509726] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.124s) [676.512244] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.304s) [677.296269] [098/130] (478s left) kms_flip (2x-modeset-vs-vblank-race-interruptible) [677.397924] Starting subtest: 2x-modeset-vs-vblank-race-interruptible [677.409767] Subtest 2x-modeset-vs-vblank-race-interruptible: SKIP (0.010s) [677.539769] [099/130] (477s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [677.649722] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [677.654189] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [677.762353] [100/130] (477s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [677.867649] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [683.029476] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (5.166s) [683.159797] [101/130] (472s left) kms_big_fb (linear-max-hw-stride-32bpp-rotate-0) [683.268505] Starting subtest: linear-max-hw-stride-32bpp-rotate-0 [684.404391] Subtest linear-max-hw-stride-32bpp-rotate-0: SUCCESS (1.135s) [684.552195] [102/130] (470s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [684.663830] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [684.667413] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [684.749448] [103/130] (470s left) kms_cursor_crc (cursor-sliding-32x32) [684.871556] Starting subtest: cursor-sliding-32x32 [684.916991] Subtest cursor-sliding-32x32: SKIP (0.041s) [685.198054] [104/130] (470s left) gem_exec_fence (basic-wait) [685.384462] Starting subtest: basic-wait [685.387104] Starting dynamic subtest: rcs0 [685.490100] Dynamic subtest rcs0: SUCCESS (0.106s) [685.501431] Starting dynamic subtest: bcs0 [685.558769] Dynamic subtest bcs0: SUCCESS (0.066s) [685.569546] Starting dynamic subtest: vcs0 [685.621888] Dynamic subtest vcs0: SUCCESS (0.062s) [685.632715] Starting dynamic subtest: vcs1 [685.689044] Dynamic subtest vcs1: SUCCESS (0.065s) [685.700807] Starting dynamic subtest: vecs0 [685.748892] Dynamic subtest vecs0: SUCCESS (0.057s) [685.760186] Starting dynamic subtest: ccs0 [685.819810] Dynamic subtest ccs0: SUCCESS (0.069s) [685.822374] Subtest basic-wait: SUCCESS (0.437s) [687.330294] [105/130] (468s left) vgem_basic (debugfs) [687.375567] Starting subtest: debugfs [687.377766] Subtest debugfs: SUCCESS (0.000s) [687.428144] [106/130] (468s left) gem_busy (extended) [687.636275] Starting subtest: extended [687.638874] Starting dynamic subtest: rcs0 [687.740635] Dynamic subtest rcs0: SUCCESS (0.104s) [687.753368] Starting dynamic subtest: bcs0 [687.785272] Dynamic subtest bcs0: SUCCESS (0.043s) [687.795591] Starting dynamic subtest: vcs0 [689.208571] Dynamic subtest vcs0: SUCCESS (1.419s) [689.221432] Starting dynamic subtest: vcs1 [691.311999] Dynamic subtest vcs1: SUCCESS (2.044s) [691.323683] Starting dynamic subtest: vecs0 [693.241378] Dynamic subtest vecs0: SUCCESS (1.984s) [693.254171] Starting dynamic subtest: ccs0 [693.288738] Dynamic subtest ccs0: SUCCESS (0.044s) [693.291193] Subtest extended: SUCCESS (5.650s) [693.534798] [107/130] (462s left) perf_pmu (pmu-read) [693.576239] Starting subtest: pmu-read [693.578630] Subtest pmu-read: SUCCESS (0.002s) [693.706677] [108/130] (461s left) kms_cursor_legacy (forked-bo) [693.839720] Starting subtest: forked-bo [693.841637] Starting dynamic subtest: pipe-A [699.402507] Dynamic subtest pipe-A: SUCCESS (5.506s) [699.411541] Starting dynamic subtest: pipe-B [704.911773] Dynamic subtest pipe-B: SUCCESS (5.507s) [704.920817] Starting dynamic subtest: pipe-C [710.399130] Dynamic subtest pipe-C: SUCCESS (5.485s) [710.408774] Starting dynamic subtest: pipe-D [715.895876] Dynamic subtest pipe-D: SUCCESS (5.493s) [715.907075] Starting dynamic subtest: all-pipes [721.428038] Dynamic subtest all-pipes: SUCCESS (5.529s) [721.430687] Subtest forked-bo: SUCCESS (27.528s) [721.507959] [109/130] (434s left) kms_psr2_sf (pr-cursor-plane-move-continuous-sf) [726.518175] Starting subtest: pr-cursor-plane-move-continuous-sf [726.526829] Subtest pr-cursor-plane-move-continuous-sf: SKIP (0.004s) [727.370981] [110/130] (428s left) gem_exec_balancer (invalid-bonds) [727.438021] Starting subtest: invalid-bonds [727.442581] Subtest invalid-bonds: SKIP (0.000s) [727.712616] [111/130] (428s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [727.818801] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [727.823289] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [727.929407] [112/130] (427s left) kms_chamelium_hpd (dp-hpd-storm-disable) [728.314624] Subtest dp-hpd-storm-disable: SKIP (0.000s) [729.077745] [113/130] (426s left) gem_lmem_swapping (basic) [729.121490] Subtest basic: SKIP (0.000s) [729.161095] [114/130] (426s left) kms_draw_crc (fill-fb) [729.270963] Starting subtest: fill-fb [729.719294] Subtest fill-fb: SUCCESS (0.450s) [729.833283] [115/130] (426s left) api_intel_allocator (two-level-inception-interruptible) [729.894376] Starting subtest: two-level-inception-interruptible [735.364579] Subtest two-level-inception-interruptible: SUCCESS (5.416s) [735.428584] [116/130] (420s left) gem_mmap_offset (ptrace) [735.491969] Starting subtest: ptrace [735.498242] Starting dynamic subtest: smem0-wb [735.512754] Dynamic subtest smem0-wb: SUCCESS (0.014s) [735.525416] Starting dynamic subtest: smem0-wc [735.530414] Dynamic subtest smem0-wc: SUCCESS (0.017s) [735.539869] Starting dynamic subtest: smem0-uc [735.550099] Dynamic subtest smem0-uc: SUCCESS (0.019s) [735.552576] Subtest ptrace: SUCCESS (0.060s) [735.660562] [117/130] (420s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [735.771992] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [740.396755] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (4.626s) [740.527334] [118/130] (415s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [740.638087] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [740.640588] Starting dynamic subtest: pipe-A-default-mode [743.389164] Dynamic subtest pipe-A-default-mode: SUCCESS (2.745s) [743.391324] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.747s) [744.250612] [119/130] (411s left) kms_big_fb (4-tiled-32bpp-rotate-90) [744.351134] Starting subtest: 4-tiled-32bpp-rotate-90 [744.370629] Subtest 4-tiled-32bpp-rotate-90: SKIP (0.019s) [744.496303] [120/130] (411s left) vgem_basic (dmabuf-export) [744.537400] Starting subtest: dmabuf-export [744.581762] Subtest dmabuf-export: SUCCESS (0.047s) [744.692694] [121/130] (411s left) i915_pm_rpm (system-suspend-execbuf) [746.427346] Starting subtest: system-suspend-execbuf [806.992049] Subtest system-suspend-execbuf: SUCCESS (45.019s) [807.351405] [122/130] (364s left) core_getstats [807.516451] [123/130] (364s left) syncobj_eventfd (invalid-illegal-eventfd) [807.576090] Starting subtest: invalid-illegal-eventfd [807.578915] Subtest invalid-illegal-eventfd: SUCCESS (0.000s) [807.684713] [124/130] (364s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [807.787455] Starting subtest: psr-rgb565-draw-mmap-cpu [812.320208] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.533s) [812.427078] [125/130] (359s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [812.539884] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [812.544891] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [812.639854] [126/130] (359s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [812.699796] Starting subtest: invalid-multi-wait-all-unsubmitted [812.702553] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [812.796467] [127/130] (359s left) kms_ccs (missing-ccs-buffer-yf-tiled-ccs) [812.899051] Starting subtest: missing-ccs-buffer-yf-tiled-ccs [812.901654] Starting dynamic subtest: pipe-A-eDP-1 [812.927045] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [812.937034] Starting dynamic subtest: pipe-B-eDP-1 [812.962091] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [812.971641] Starting dynamic subtest: pipe-C-eDP-1 [812.998180] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [813.007650] Starting dynamic subtest: pipe-D-eDP-1 [813.033632] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [813.038753] Subtest missing-ccs-buffer-yf-tiled-ccs: SKIP (0.004s) [815.060783] [128/130] (356s left) dmabuf_sync_file (import-basic) [815.108403] Starting subtest: import-basic [815.110996] Subtest import-basic: SUCCESS (0.004s) [815.162752] [129/130] (356s left) gem_exec_reloc (basic-wc-active) [815.228085] Subtest basic-wc-active: SKIP (0.000s) [815.316506] [130/130] (356s left) gem_softpin (safe-alignment) [815.378816] Starting subtest: safe-alignment [815.404764] Subtest safe-alignment: SUCCESS (0.027s) [816.792729] Closing watchdogs Done.