[57.065639] Initializing watchdogs [57.065682] /dev/watchdog0 [57.081259] [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] [57.085851] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [57.088581] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [57.091976] [001/156] (960s left) kms_big_fb (x-tiled-addfb-size-offset-overflow) [57.219134] Starting subtest: x-tiled-addfb-size-offset-overflow [57.221369] Subtest x-tiled-addfb-size-offset-overflow: SUCCESS (0.000s) [57.323690] [002/156] (960s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [57.422923] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [57.425340] Starting dynamic subtest: pipe-A-default-mode [60.119496] Dynamic subtest pipe-A-default-mode: SUCCESS (2.742s) [60.121789] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.743s) [60.947984] [003/156] (956s left) gem_exec_params (batch-first) [61.011958] Starting subtest: batch-first [61.017996] Subtest batch-first: SUCCESS (0.006s) [61.144520] [004/156] (956s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-blt) [61.248253] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-blt [61.252414] Subtest psrhdr-1p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [61.342231] [005/156] (956s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [61.444456] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-mmap-gtt [61.448984] Subtest hdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [61.537627] [006/156] (956s left) kms_cursor_crc (cursor-sliding-512x512) [61.795874] Starting subtest: cursor-sliding-512x512 [61.800346] Subtest cursor-sliding-512x512: SKIP (0.001s) [61.942404] [007/156] (955s left) kms_flip (2x-flip-vs-dpms) [62.039431] Starting subtest: 2x-flip-vs-dpms [62.051215] Subtest 2x-flip-vs-dpms: SKIP (0.011s) [62.132268] [008/156] (955s left) kms_frontbuffer_tracking (psr-1p-pri-indfb-multidraw) [62.231925] Starting subtest: psr-1p-pri-indfb-multidraw [85.770441] Subtest psr-1p-pri-indfb-multidraw: SUCCESS (23.617s) [85.893203] [009/156] (931s left) i915_power (sanity) [85.955061] Starting subtest: sanity [90.001303] Subtest sanity: SUCCESS (4.038s) [91.327806] [010/156] (926s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu) [91.436718] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu [91.440853] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [91.533343] [011/156] (926s left) kms_flip (2x-absolute-wf_vblank) [91.633124] Starting subtest: 2x-absolute-wf_vblank [91.642659] Subtest 2x-absolute-wf_vblank: SKIP (0.011s) [91.718960] [012/156] (926s left) perf_pmu (semaphore-busy) [91.764234] Starting subtest: semaphore-busy [91.766201] Starting dynamic subtest: rcs0 [93.409968] Dynamic subtest rcs0: SUCCESS (1.642s) [93.422978] Starting dynamic subtest: bcs0 [95.039907] Dynamic subtest bcs0: SUCCESS (1.628s) [95.051902] Starting dynamic subtest: vcs0 [98.806298] Dynamic subtest vcs0: SUCCESS (3.763s) [98.817339] Starting dynamic subtest: vcs1 [104.824191] Dynamic subtest vcs1: SUCCESS (6.015s) [104.835693] Starting dynamic subtest: vecs0 [110.775107] Dynamic subtest vecs0: SUCCESS (5.948s) [110.785956] Starting dynamic subtest: ccs0 [113.912543] Dynamic subtest ccs0: SUCCESS (3.135s) [113.915160] Subtest semaphore-busy: SUCCESS (22.144s) [114.025935] [013/156] (904s left) kms_content_protection (dp-mst-type-1) [114.169889] Starting subtest: dp-mst-type-1 [114.174742] Subtest dp-mst-type-1: SKIP (0.000s) [114.291994] [014/156] (903s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-blt) [114.399596] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-blt [121.448018] Subtest psr-1p-offscreen-pri-shrfb-draw-blt: SUCCESS (7.053s) [121.582364] [015/156] (896s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip) [121.682705] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip [122.562424] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SUCCESS (0.881s) [122.722106] [016/156] (895s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers) [122.814922] Starting subtest: plane-upscale-factor-0-25-with-modifiers [122.817139] Starting dynamic subtest: pipe-A [123.150878] Dynamic subtest pipe-A: SUCCESS (0.338s) [123.160338] Starting dynamic subtest: pipe-B [124.535770] Dynamic subtest pipe-B: SUCCESS (1.384s) [124.547361] Starting dynamic subtest: pipe-C [125.973600] Dynamic subtest pipe-C: SUCCESS (1.437s) [125.982316] Starting dynamic subtest: pipe-D [127.409455] Dynamic subtest pipe-D: SUCCESS (1.435s) [127.411874] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.597s) [128.565957] [017/156] (889s left) prime_busy (after-wait) [128.629584] Starting subtest: after-wait [128.634282] Starting dynamic subtest: rcs0 [128.668603] Dynamic subtest rcs0: SUCCESS (0.035s) [128.679518] Starting dynamic subtest: bcs0 [128.718630] Dynamic subtest bcs0: SUCCESS (0.050s) [128.728620] Starting dynamic subtest: vcs0 [128.759588] Dynamic subtest vcs0: SUCCESS (0.040s) [128.768894] Starting dynamic subtest: vcs1 [128.800772] Dynamic subtest vcs1: SUCCESS (0.041s) [128.809170] Starting dynamic subtest: vecs0 [128.840605] Dynamic subtest vecs0: SUCCESS (0.038s) [128.851536] Starting dynamic subtest: ccs0 [128.881761] Dynamic subtest ccs0: SUCCESS (0.042s) [128.990848] Subtest after-wait: SUCCESS (0.359s) [129.064630] [018/156] (889s left) gem_close_race (basic-process) [129.121089] Starting subtest: basic-process [129.164536] Subtest basic-process: SUCCESS (0.046s) [129.341510] [019/156] (888s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt) [129.437342] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt [129.441854] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [129.525392] [020/156] (888s left) kms_cursor_crc (cursor-random-64x21) [129.718960] Starting subtest: cursor-random-64x21 [129.767016] Subtest cursor-random-64x21: SKIP (0.046s) [129.993446] [021/156] (888s left) kms_debugfs (display-off-read-all) [130.095382] Starting subtest: display-off-read-all [130.387604] Subtest display-off-read-all: SUCCESS (0.290s) [131.196889] [022/156] (887s left) kms_psr (psr2-primary-render) [131.287196] Starting subtest: psr2-primary-render [131.289900] Starting dynamic subtest: eDP-1 [133.009201] Dynamic subtest eDP-1: SUCCESS (1.721s) [133.011560] Subtest psr2-primary-render: SUCCESS (1.722s) [133.887527] [023/156] (884s left) gem_workarounds (reset-context) [133.946579] Starting subtest: reset-context [134.119672] Subtest reset-context: SUCCESS (0.171s) [134.270625] [024/156] (884s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [134.337525] Starting subtest: x-tiled-to-vebox-yf-tiled [134.342386] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [134.525767] [025/156] (883s left) gem_flink_race (flink_name) [134.556499] Starting subtest: flink_name [139.960110] Subtest flink_name: SUCCESS (5.400s) [140.058825] [026/156] (878s left) i915_module_load (reload) [140.094952] Starting subtest: reload [144.956862] Subtest reload: SUCCESS (4.866s) [144.997259] [027/156] (873s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [146.320874] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [146.324967] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s) [146.389555] [028/156] (872s left) drm_read (empty-nonblock) [146.550625] Starting subtest: empty-nonblock [146.552941] Subtest empty-nonblock: SUCCESS (0.000s) [146.698431] [029/156] (871s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt) [146.801563] Starting subtest: psr-rgb565-draw-blt [153.940671] Subtest psr-rgb565-draw-blt: SUCCESS (7.144s) [154.062933] [030/156] (864s left) api_intel_bb (crc32) [154.126609] Starting subtest: crc32 [154.128822] Starting dynamic subtest: rcs0-smem0 [154.427876] Dynamic subtest rcs0-smem0: SUCCESS (0.302s) [154.440892] Starting dynamic subtest: bcs0-smem0 [154.743410] Dynamic subtest bcs0-smem0: SUCCESS (0.311s) [154.754783] Starting dynamic subtest: vcs0-smem0 [155.138636] Dynamic subtest vcs0-smem0: SUCCESS (0.393s) [155.151750] Starting dynamic subtest: vcs1-smem0 [155.512418] Dynamic subtest vcs1-smem0: SUCCESS (0.371s) [155.524097] Starting dynamic subtest: vecs0-smem0 [155.899972] Dynamic subtest vecs0-smem0: SUCCESS (0.385s) [155.912274] Starting dynamic subtest: ccs0-smem0 [156.220207] Dynamic subtest ccs0-smem0: SUCCESS (0.317s) [156.222995] Subtest crc32: SUCCESS (2.097s) [156.345168] [031/156] (862s left) gem_mmap_gtt (basic-read-write) [156.412144] Subtest basic-read-write: SKIP (0.000s) [156.466840] [032/156] (862s left) kms_hdr (bpc-switch) [156.569805] Starting subtest: bpc-switch [156.572157] Starting dynamic subtest: pipe-A-eDP-1-XRGB2101010 [161.192768] Dynamic subtest pipe-A-eDP-1-XRGB2101010: SUCCESS (4.623s) [161.203281] Starting dynamic subtest: pipe-A-eDP-1-XRGB16161616F [165.727192] Dynamic subtest pipe-A-eDP-1-XRGB16161616F: SUCCESS (4.533s) [165.729707] Subtest bpc-switch: SUCCESS (9.158s) [165.830328] [033/156] (853s left) gem_fence_thrash (bo-write-verify-none) [165.866356] Starting subtest: bo-write-verify-none [165.891783] Subtest bo-write-verify-none: SKIP (0.023s) [165.959626] [034/156] (852s left) kms_ccs (bad-aux-stride-y-tiled-gen12-rc-ccs-cc) [166.058506] Starting subtest: bad-aux-stride-y-tiled-gen12-rc-ccs-cc [166.060883] Starting dynamic subtest: pipe-A-eDP-1 [166.084212] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [166.094388] Starting dynamic subtest: pipe-B-eDP-1 [166.116406] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [166.125265] Starting dynamic subtest: pipe-C-eDP-1 [166.147183] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [166.155961] Starting dynamic subtest: pipe-D-eDP-1 [166.178294] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [166.182238] Subtest bad-aux-stride-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [168.345364] [035/156] (850s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [168.441963] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [168.446277] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [168.552458] [036/156] (850s left) kms_frontbuffer_tracking (fbchdr-tiling-linear) [168.659557] Starting subtest: fbchdr-tiling-linear [168.663693] Subtest fbchdr-tiling-linear: SKIP (0.000s) [168.754472] [037/156] (850s left) kms_pm_dc (dc5-dpms-negative) [169.854935] Starting subtest: dc5-dpms-negative [169.859308] Subtest dc5-dpms-negative: SKIP (0.000s) [169.926467] [038/156] (849s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-msflip-blt) [170.031605] Starting subtest: fbc-1p-primscrn-shrfb-msflip-blt [174.564363] Subtest fbc-1p-primscrn-shrfb-msflip-blt: SUCCESS (4.540s) [175.738188] [039/156] (843s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt) [175.841183] Starting subtest: fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt [175.845383] Subtest fbcpsrhdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [175.939031] [040/156] (843s left) kms_universal_plane (disable-primary-vs-flip) [176.031645] Starting subtest: disable-primary-vs-flip [176.033873] Starting dynamic subtest: pipe-A-eDP-1 [177.617262] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.584s) [177.626960] Starting dynamic subtest: pipe-B-eDP-1 [179.855784] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.240s) [179.868495] Starting dynamic subtest: pipe-C-eDP-1 [182.108464] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.252s) [182.118910] Starting dynamic subtest: pipe-D-eDP-1 [184.286703] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.175s) [184.289080] Subtest disable-primary-vs-flip: SUCCESS (8.257s) [185.176633] [041/156] (833s left) gem_pread (bench) [185.235125] Subtest bench: SKIP (0.000s) [185.295087] [042/156] (833s left) kms_chamelium_edid (dp-edid-resolution-list) [185.670357] Subtest dp-edid-resolution-list: SKIP (0.000s) [186.489958] [043/156] (832s left) kms_hdmi_inject (inject-audio) [186.848981] Starting subtest: inject-audio [187.147602] Subtest inject-audio: SUCCESS (0.300s) [187.685471] [044/156] (831s left) syncobj_timeline (wait-for-submit-snapshot) [187.744157] Starting subtest: wait-for-submit-snapshot [187.826165] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [187.902499] [045/156] (831s left) gem_exec_reloc (basic-wc-read-noreloc) [187.967096] Subtest basic-wc-read-noreloc: SKIP (0.000s) [188.033535] [046/156] (831s left) kms_frontbuffer_tracking (hdr-1p-offscreen-pri-shrfb-draw-pwrite) [188.140339] Starting subtest: hdr-1p-offscreen-pri-shrfb-draw-pwrite [188.144571] Subtest hdr-1p-offscreen-pri-shrfb-draw-pwrite: SKIP (0.000s) [188.240836] [047/156] (831s left) kms_ccs (missing-ccs-buffer-4-tiled-mtl-mc-ccs) [188.339260] Starting subtest: missing-ccs-buffer-4-tiled-mtl-mc-ccs [188.341081] Starting dynamic subtest: pipe-A-eDP-1 [188.361232] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.021s) [188.372785] Starting dynamic subtest: pipe-B-eDP-1 [188.392297] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.021s) [188.402460] Starting dynamic subtest: pipe-C-eDP-1 [188.421601] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.020s) [188.430717] Starting dynamic subtest: pipe-D-eDP-1 [188.450663] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.020s) [188.452967] Subtest missing-ccs-buffer-4-tiled-mtl-mc-ccs: SUCCESS (0.087s) [190.647854] [048/156] (828s left) kms_big_fb (y-tiled-16bpp-rotate-0) [190.749455] Starting subtest: y-tiled-16bpp-rotate-0 [190.753742] Subtest y-tiled-16bpp-rotate-0: SKIP (0.000s) [190.862136] [049/156] (828s left) gem_lmem_swapping (heavy-verify-multi-ccs) [190.905168] Subtest heavy-verify-multi-ccs: SKIP (0.000s) [190.946780] [050/156] (828s left) drm_read (empty-block) [191.081185] Starting subtest: empty-block [192.083135] Subtest empty-block: SUCCESS (1.000s) [192.218603] [051/156] (827s left) gem_exec_schedule (preempt-queue-contexts-chain) [192.287631] Subtest preempt-queue-contexts-chain: SKIP (0.000s) [192.591497] [052/156] (827s left) fbdev (pan) [192.625668] Starting subtest: pan [192.651353] Subtest pan: SUCCESS (0.030s) [192.722461] [053/156] (826s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [192.806105] Starting subtest: nonblocking-crc-frame-sequence [192.808431] Starting dynamic subtest: pipe-A-eDP-1 [193.550850] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.742s) [193.561093] Starting dynamic subtest: pipe-B-eDP-1 [195.037080] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.485s) [195.048494] Starting dynamic subtest: pipe-C-eDP-1 [196.404461] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.365s) [196.414321] Starting dynamic subtest: pipe-D-eDP-1 [197.792250] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.386s) [197.794789] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.986s) [198.639397] [054/156] (821s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-fullscreen) [198.733656] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-fullscreen [198.737762] Subtest fbcpsr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [198.854236] [055/156] (820s left) gem_ctx_shared (exec-single-timeline) [198.921595] Starting subtest: exec-single-timeline [198.923846] Starting dynamic subtest: rcs0 [199.959830] Dynamic subtest rcs0: SUCCESS (1.036s) [199.972986] Starting dynamic subtest: bcs0 [201.049739] Dynamic subtest bcs0: SUCCESS (1.086s) [201.061972] Starting dynamic subtest: vcs0 [202.137074] Dynamic subtest vcs0: SUCCESS (1.084s) [202.150356] Starting dynamic subtest: vcs1 [203.224610] Dynamic subtest vcs1: SUCCESS (1.084s) [203.238307] Starting dynamic subtest: vecs0 [204.313050] Dynamic subtest vecs0: SUCCESS (1.087s) [204.325819] Starting dynamic subtest: ccs0 [205.401419] Dynamic subtest ccs0: SUCCESS (1.085s) [205.404433] Subtest exec-single-timeline: SUCCESS (6.479s) [205.634499] [056/156] (814s left) gem_mmap_gtt (cpuset-big-copy-xy) [205.698066] Subtest cpuset-big-copy-XY: SKIP (0.000s) [205.768729] [057/156] (814s left) gem_wait (await) [205.836852] Starting subtest: await [205.839187] Starting dynamic subtest: all-engines [206.984673] Dynamic subtest all-engines: SUCCESS (1.147s) [207.003587] Starting dynamic subtest: rcs0 [208.041294] Dynamic subtest rcs0: SUCCESS (1.054s) [208.059162] Starting dynamic subtest: bcs0 [209.098742] Dynamic subtest bcs0: SUCCESS (1.055s) [209.116036] Starting dynamic subtest: vcs0 [210.151310] Dynamic subtest vcs0: SUCCESS (1.051s) [210.167832] Starting dynamic subtest: vcs1 [211.204621] Dynamic subtest vcs1: SUCCESS (1.051s) [211.222064] Starting dynamic subtest: vecs0 [212.259638] Dynamic subtest vecs0: SUCCESS (1.052s) [212.275594] Starting dynamic subtest: ccs0 [213.317012] Dynamic subtest ccs0: SUCCESS (1.055s) [213.319486] Subtest await: SUCCESS (7.481s) [213.526665] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true [213.530914] [058/156] (806s left) gem_ctx_engines (execute-oneforall) [213.580084] Starting subtest: execute-oneforall [214.486332] Subtest execute-oneforall: SUCCESS (0.904s) [215.427382] [059/156] (804s left) gem_ctx_persistence (idempotent) [215.497983] Starting subtest: idempotent [215.500246] Subtest idempotent: SUCCESS (0.000s) [215.600285] [060/156] (804s left) kms_pwrite_crc (basic) [215.692960] Starting subtest: basic [216.396917] Subtest basic: SUCCESS (0.704s) [217.244217] [061/156] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu) [217.337016] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu [224.427359] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.095s) [224.553460] [062/156] (795s left) kms_flip (flip-vs-expired-vblank) [224.648873] Starting subtest: flip-vs-expired-vblank [224.650801] Starting dynamic subtest: A-eDP1 [233.313745] Dynamic subtest A-eDP1: SUCCESS (8.666s) [233.324873] Starting dynamic subtest: B-eDP1 [242.014741] Dynamic subtest B-eDP1: SUCCESS (8.700s) [242.027451] Starting dynamic subtest: C-eDP1 [250.692699] Dynamic subtest C-eDP1: SUCCESS (8.675s) [250.705637] Starting dynamic subtest: D-eDP1 [259.392641] Dynamic subtest D-eDP1: SUCCESS (8.697s) [259.397964] Subtest flip-vs-expired-vblank: SUCCESS (34.750s) [260.647368] [063/156] (759s left) gem_exec_balancer (bonded-semaphore) [260.715344] Starting subtest: bonded-semaphore [260.719941] Subtest bonded-semaphore: SKIP (0.000s) [261.001140] [064/156] (759s left) kms_chamelium_hpd (dp-hpd-storm-disable) [261.391458] Subtest dp-hpd-storm-disable: SKIP (0.000s) [262.223976] [065/156] (757s left) core_auth (basic-auth) [262.277441] Starting subtest: basic-auth [262.279381] Subtest basic-auth: SUCCESS (0.001s) [262.364646] [066/156] (757s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [262.481139] Starting subtest: extended-modeset-hang-oldfb-with-reset [262.483426] Starting dynamic subtest: pipe-A [274.576899] Dynamic subtest pipe-A: SUCCESS (12.092s) [274.589897] Starting dynamic subtest: pipe-D [287.002513] Dynamic subtest pipe-D: SUCCESS (12.425s) [287.004880] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (24.522s) [287.847978] [067/156] (732s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-shrfb-plflip-blt) [287.947573] Starting subtest: fbchdr-2p-scndscrn-shrfb-plflip-blt [287.951888] Subtest fbchdr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [288.051304] [068/156] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt) [288.143282] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt [288.147172] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s) [288.257277] [069/156] (732s left) kms_color_pipeline (plane-ctm3x4) [288.365216] Starting subtest: plane-ctm3x4 [288.546622] Starting dynamic subtest: pipe-A-plane-0 [288.690727] Dynamic subtest pipe-A-plane-0: SUCCESS (0.144s) [288.700925] Starting dynamic subtest: pipe-A-plane-1 [288.824200] Dynamic subtest pipe-A-plane-1: SUCCESS (0.133s) [288.836523] Starting dynamic subtest: pipe-A-plane-2 [288.957431] Dynamic subtest pipe-A-plane-2: SUCCESS (0.132s) [290.218676] Starting dynamic subtest: pipe-B-plane-0 [290.377948] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s) [290.388308] Starting dynamic subtest: pipe-B-plane-1 [290.511740] Dynamic subtest pipe-B-plane-1: SUCCESS (0.133s) [290.524029] Starting dynamic subtest: pipe-B-plane-2 [290.643575] Dynamic subtest pipe-B-plane-2: SUCCESS (0.133s) [291.906245] Starting dynamic subtest: pipe-C-plane-0 [292.053425] Dynamic subtest pipe-C-plane-0: SUCCESS (0.155s) [292.063888] Starting dynamic subtest: pipe-C-plane-1 [292.177055] Dynamic subtest pipe-C-plane-1: SUCCESS (0.121s) [292.187245] Starting dynamic subtest: pipe-C-plane-2 [292.309666] Dynamic subtest pipe-C-plane-2: SUCCESS (0.133s) [293.522055] Starting dynamic subtest: pipe-D-plane-0 [293.660048] Dynamic subtest pipe-D-plane-0: SUCCESS (0.144s) [293.670182] Starting dynamic subtest: pipe-D-plane-1 [293.780513] Dynamic subtest pipe-D-plane-1: SUCCESS (0.122s) [293.793942] Starting dynamic subtest: pipe-D-plane-2 [293.914123] Dynamic subtest pipe-D-plane-2: SUCCESS (0.133s) [294.214316] Subtest plane-ctm3x4: SUCCESS (5.848s) [295.034513] [070/156] (725s left) gem_mmap_gtt (basic-write-read) [295.100144] Subtest basic-write-read: SKIP (0.000s) [295.169375] [071/156] (725s left) kms_ccs (crc-primary-rotation-180-yf-tiled-ccs) [295.259413] Starting subtest: crc-primary-rotation-180-yf-tiled-ccs [295.261677] Starting dynamic subtest: pipe-A-eDP-1 [295.284054] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [295.296335] Starting dynamic subtest: pipe-B-eDP-1 [295.318844] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [295.328254] Starting dynamic subtest: pipe-C-eDP-1 [295.349895] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [295.359395] Starting dynamic subtest: pipe-D-eDP-1 [295.381704] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [295.385830] Subtest crc-primary-rotation-180-yf-tiled-ccs: SKIP (0.006s) [297.536437] [072/156] (722s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-plflip-blt) [297.645381] Starting subtest: psrhdr-2p-scndscrn-indfb-plflip-blt [297.649552] Subtest psrhdr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s) [297.747016] [073/156] (722s left) gem_render_copy (y-tiled-ccs-to-x-tiled) [297.808488] Starting subtest: y-tiled-ccs-to-x-tiled [297.812731] Subtest y-tiled-ccs-to-x-tiled: SKIP (0.000s) [297.996346] [074/156] (722s left) gem_mmap_gtt (basic-short) [298.050276] Subtest basic-short: SKIP (0.000s) [298.125582] [075/156] (722s left) gem_set_tiling_vs_blt (untiled-to-tiled) [298.182178] Subtest untiled-to-tiled: SKIP (0.000s) [298.263463] [076/156] (722s left) gem_softpin (noreloc-s3) [298.332939] Starting subtest: noreloc-S3 [318.472605] Subtest noreloc-S3: SUCCESS (5.429s) [318.657031] [077/156] (702s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite) [318.781154] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite [318.785561] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [318.886080] [078/156] (701s left) gem_exec_whisper (basic-contexts-priority) [318.954654] Starting subtest: basic-contexts-priority [342.599955] Subtest basic-contexts-priority: SUCCESS (23.833s) [342.785170] [079/156] (678s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [342.883007] Starting subtest: primary-y-tiled-reflect-x-270 [342.887452] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [342.967321] [080/156] (677s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc) [343.065361] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc [343.069458] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [343.160990] [081/156] (677s left) kms_vrr (flip-suspend) [343.259592] Starting subtest: flip-suspend [343.266206] Subtest flip-suspend: SKIP (0.000s) [343.334412] [082/156] (677s left) gem_exec_fence (nb-await) [343.519739] Starting subtest: nb-await [343.522584] Starting dynamic subtest: rcs0 [343.586453] Dynamic subtest rcs0: SUCCESS (0.068s) [343.600340] Starting dynamic subtest: bcs0 [343.645179] Dynamic subtest bcs0: SUCCESS (0.057s) [343.657745] Starting dynamic subtest: vcs0 [343.704695] Dynamic subtest vcs0: SUCCESS (0.057s) [343.717753] Starting dynamic subtest: vcs1 [343.762727] Dynamic subtest vcs1: SUCCESS (0.056s) [343.774792] Starting dynamic subtest: vecs0 [343.820571] Dynamic subtest vecs0: SUCCESS (0.056s) [343.833991] Starting dynamic subtest: ccs0 [343.878593] Dynamic subtest ccs0: SUCCESS (0.056s) [343.881330] Subtest nb-await: SUCCESS (0.363s) [346.143604] [083/156] (674s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [346.244799] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [346.247335] Starting dynamic subtest: pipe-A-eDP-1 [346.273910] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [346.286706] Starting dynamic subtest: pipe-B-eDP-1 [346.310300] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [346.321124] Starting dynamic subtest: pipe-C-eDP-1 [346.346721] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [346.358171] Starting dynamic subtest: pipe-D-eDP-1 [346.384011] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [346.388256] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [348.517560] [084/156] (672s left) kms_async_flips (invalid-async-flip) [348.613925] Starting subtest: invalid-async-flip [349.000132] Starting dynamic subtest: pipe-A-eDP-1 [349.821062] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.821s) [350.192482] Starting dynamic subtest: pipe-B-eDP-1 [351.017503] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.833s) [351.375360] Starting dynamic subtest: pipe-C-eDP-1 [352.209987] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.843s) [352.572536] Starting dynamic subtest: pipe-D-eDP-1 [353.405791] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.844s) [353.408200] Subtest invalid-async-flip: SUCCESS (4.792s) [354.633171] [085/156] (666s left) gem_exec_suspend (basic) [354.696281] Starting subtest: basic [354.698708] Starting dynamic subtest: smem [356.113174] Dynamic subtest smem: SUCCESS (1.414s) [356.116106] Subtest basic: SUCCESS (1.417s) [356.304332] [086/156] (664s left) gem_ctx_isolation (preservation-s3) [356.374581] Starting subtest: preservation-S3 [356.376854] Starting dynamic subtest: rcs0 [373.281035] Dynamic subtest rcs0: SUCCESS (1.329s) [373.292555] Starting dynamic subtest: bcs0 [389.277001] Dynamic subtest bcs0: SUCCESS (1.299s) [389.292357] Starting dynamic subtest: vcs0 [405.286888] Dynamic subtest vcs0: SUCCESS (3.264s) [405.299629] Starting dynamic subtest: vcs1 [423.285069] Dynamic subtest vcs1: SUCCESS (5.132s) [423.297618] Starting dynamic subtest: vecs0 [441.274142] Dynamic subtest vecs0: SUCCESS (5.133s) [441.285572] Starting dynamic subtest: ccs0 [459.259012] Dynamic subtest ccs0: SUCCESS (3.278s) [459.261356] Subtest preservation-S3: SUCCESS (19.441s) [459.487894] [087/156] (561s left) kms_big_fb (yf-tiled-8bpp-rotate-90) [459.585312] Starting subtest: yf-tiled-8bpp-rotate-90 [459.589485] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s) [459.696691] [088/156] (561s left) kms_psr (pr-cursor-plane-move) [459.801559] Starting subtest: pr-cursor-plane-move [459.805875] Subtest pr-cursor-plane-move: SKIP (0.000s) [459.873987] [089/156] (561s left) kms_cursor_crc (cursor-offscreen-128x42) [460.087413] Starting subtest: cursor-offscreen-128x42 [460.135697] Subtest cursor-offscreen-128x42: SKIP (0.045s) [460.331447] [090/156] (560s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-shrfb-msflip-blt) [460.438943] Starting subtest: hdr-2p-scndscrn-shrfb-msflip-blt [460.442070] Subtest hdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [460.555721] [091/156] (560s left) gem_mmap (short-mmap) [460.617433] Subtest short-mmap: SKIP (0.000s) [460.678145] [092/156] (560s left) kms_big_fb (4-tiled-addfb-size-overflow) [460.772091] Starting subtest: 4-tiled-addfb-size-overflow [460.773959] Subtest 4-tiled-addfb-size-overflow: SUCCESS (0.000s) [460.879067] [093/156] (560s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-wc) [460.980245] Starting subtest: hdr-rgb101010-draw-mmap-wc [460.984359] Subtest hdr-rgb101010-draw-mmap-wc: SKIP (0.000s) [461.089240] [094/156] (560s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted) [461.138181] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted [461.245460] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.109s) [461.332436] [095/156] (560s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite) [461.421273] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite [461.425473] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [461.530836] [096/156] (559s left) syncobj_wait (wait-for-submit-complex) [461.581488] Starting subtest: wait-for-submit-complex [461.643659] Subtest wait-for-submit-complex: SUCCESS (0.064s) [461.720107] [097/156] (559s left) kms_frontbuffer_tracking (fbcpsrhdr-rgb101010-draw-mmap-cpu) [461.820061] Starting subtest: fbcpsrhdr-rgb101010-draw-mmap-cpu [461.824404] Subtest fbcpsrhdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [461.920959] [098/156] (559s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-render) [462.021900] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-render [462.026251] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [462.123124] [099/156] (559s left) kms_psr (fbc-pr-no-drrs) [462.211265] Starting subtest: fbc-pr-no-drrs [462.215451] Subtest fbc-pr-no-drrs: SKIP (0.000s) [462.284711] [100/156] (559s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [462.342745] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [462.344622] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.001s) [462.448144] [101/156] (559s left) gem_softpin (reverse) [462.501472] Starting subtest: reverse [462.506589] Subtest reverse: SUCCESS (0.005s) [462.620340] [102/156] (559s left) kms_addfb_basic (master-rmfb) [462.665180] Starting subtest: master-rmfb [462.667092] Subtest master-rmfb: SUCCESS (0.001s) [462.809202] [103/156] (559s left) gem_exec_schedule (deep) [462.989331] Starting subtest: deep [462.991625] Starting dynamic subtest: rcs0 [468.226877] Dynamic subtest rcs0: SKIP (5.325s) [468.240705] Starting dynamic subtest: vcs0 [478.505207] Dynamic subtest vcs0: SUCCESS (10.350s) [478.519085] Starting dynamic subtest: vcs1 [489.315292] Dynamic subtest vcs1: SUCCESS (10.831s) [489.327163] Starting dynamic subtest: vecs0 [500.381119] Dynamic subtest vecs0: SUCCESS (11.056s) [500.399821] Starting dynamic subtest: ccs0 [512.749865] Dynamic subtest ccs0: SUCCESS (12.364s) [512.752384] Subtest deep: SUCCESS (49.931s) [514.585309] [104/156] (507s left) core_setmaster (master-drop-set-user) [514.659787] Starting subtest: master-drop-set-user [514.669866] Subtest master-drop-set-user: SUCCESS (0.012s) [514.711775] [105/156] (507s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-spr-indfb-move) [514.809883] Starting subtest: fbchdr-2p-primscrn-spr-indfb-move [514.814186] Subtest fbchdr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [514.923830] [106/156] (507s left) kms_plane_scaling (planes-downscale-factor-0-5) [515.020349] Starting subtest: planes-downscale-factor-0-5 [515.022627] Starting dynamic subtest: pipe-A [515.045236] Dynamic subtest pipe-A: SKIP (0.019s) [515.057701] Starting dynamic subtest: pipe-B [515.079168] Dynamic subtest pipe-B: SKIP (0.035s) [515.090415] Starting dynamic subtest: pipe-C [515.114265] Dynamic subtest pipe-C: SKIP (0.034s) [515.125104] Starting dynamic subtest: pipe-D [515.148425] Dynamic subtest pipe-D: SKIP (0.034s) [515.153113] Subtest planes-downscale-factor-0-5: SKIP (0.125s) [515.250458] [107/156] (506s left) gem_exec_fence (basic-await) [515.438440] Starting subtest: basic-await [515.440879] Starting dynamic subtest: rcs0 [515.511723] Dynamic subtest rcs0: SUCCESS (0.076s) [515.524742] Starting dynamic subtest: bcs0 [515.590346] Dynamic subtest bcs0: SUCCESS (0.077s) [515.605658] Starting dynamic subtest: vcs0 [515.662768] Dynamic subtest vcs0: SUCCESS (0.071s) [515.676804] Starting dynamic subtest: vcs1 [515.736406] Dynamic subtest vcs1: SUCCESS (0.073s) [515.750564] Starting dynamic subtest: vecs0 [515.810755] Dynamic subtest vecs0: SUCCESS (0.072s) [515.824748] Starting dynamic subtest: ccs0 [515.883487] Dynamic subtest ccs0: SUCCESS (0.071s) [515.885902] Subtest basic-await: SUCCESS (0.450s) [518.082009] [108/156] (503s left) kms_psr (fbc-psr2-sprite-render) [518.178681] Starting subtest: fbc-psr2-sprite-render [518.181010] Starting dynamic subtest: eDP-1 [518.185439] Dynamic subtest eDP-1: SKIP (0.000s) [518.189922] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [518.256175] [109/156] (503s left) syncobj_timeline (invalid-signal-bad-pad) [518.308558] Starting subtest: invalid-signal-bad-pad [518.310466] Subtest invalid-signal-bad-pad: SUCCESS (0.000s) [518.430965] [110/156] (503s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-upscaling) [518.538960] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-upscaling [518.542857] Subtest flip-32bpp-yftile-to-64bpp-yftile-upscaling: SKIP (0.000s) [518.615341] [111/156] (503s left) kms_lease (empty-lease) [518.711795] Starting subtest: empty-lease [518.714037] Starting dynamic subtest: pipe-A-eDP-1 [518.716348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [518.727688] Starting dynamic subtest: pipe-B-eDP-1 [518.729957] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [518.740709] Starting dynamic subtest: pipe-C-eDP-1 [518.742931] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [518.753799] Starting dynamic subtest: pipe-D-eDP-1 [518.756051] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [518.758295] Subtest empty-lease: SUCCESS (0.009s) [518.822820] [112/156] (503s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-move) [518.919868] Starting subtest: psrhdr-1p-primscrn-spr-indfb-move [518.924082] Subtest psrhdr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [519.025055] [113/156] (503s left) gem_render_copy_redux (interruptible) [519.080158] Starting subtest: interruptible [519.361746] Subtest interruptible: SUCCESS (0.282s) [519.474054] [114/156] (502s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-offscreen-pri-indfb-draw-render) [519.579010] Starting subtest: fbcpsrhdr-1p-offscreen-pri-indfb-draw-render [519.582763] Subtest fbcpsrhdr-1p-offscreen-pri-indfb-draw-render: SKIP (0.000s) [519.669837] [115/156] (502s left) kms_psr (fbc-psr-no-drrs) [519.766104] Starting subtest: fbc-psr-no-drrs [519.767966] Starting dynamic subtest: eDP-1 [519.771325] Dynamic subtest eDP-1: SKIP (0.000s) [519.774747] Subtest fbc-psr-no-drrs: SKIP (0.001s) [519.842680] [116/156] (502s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [519.891883] Starting subtest: y-tiled-to-vebox-x-tiled [519.895622] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [520.079525] [117/156] (502s left) gen7_exec_parse (oacontrol-tracking) [520.140073] Subtest oacontrol-tracking: SKIP (0.000s) [520.223651] [118/156] (502s left) i915_drm_fdinfo (context-close-stress) [520.258001] Starting subtest: context-close-stress [531.001498] Subtest context-close-stress: SUCCESS (10.745s) [531.080921] [119/156] (491s left) i915_pm_rc6_residency (rc6-idle) [531.271228] Starting subtest: rc6-idle [531.297161] Starting dynamic subtest: gt0-rcs0 [555.575929] Dynamic subtest gt0-rcs0: SUCCESS (24.284s) [555.586923] Starting dynamic subtest: gt0-bcs0 [579.792475] Dynamic subtest gt0-bcs0: SUCCESS (24.208s) [579.803252] Starting dynamic subtest: gt0-ccs0 [604.221573] Dynamic subtest gt0-ccs0: SUCCESS (24.426s) [604.232503] Starting dynamic subtest: gt1-vcs0 [610.394981] Dynamic subtest gt1-vcs0: SUCCESS (6.170s) [610.408381] Starting dynamic subtest: gt1-vecs0 [616.567097] Dynamic subtest gt1-vecs0: SUCCESS (6.170s) [616.569877] Subtest rc6-idle: SUCCESS (85.298s) [616.653405] [120/156] (405s left) syncobj_wait (multi-wait-for-submit-unsubmitted-submitted-signaled) [616.705499] Starting subtest: multi-wait-for-submit-unsubmitted-submitted-signaled [616.707772] Subtest multi-wait-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.000s) [616.800490] [121/156] (405s left) kms_plane (pixel-format-y-tiled-ccs-modifier) [616.899527] Starting subtest: pixel-format-y-tiled-ccs-modifier [616.903803] Subtest pixel-format-y-tiled-ccs-modifier: SKIP (0.000s) [616.972602] [122/156] (405s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt) [617.066412] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt [617.070666] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [617.178015] [123/156] (405s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [617.275239] Starting subtest: psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt [617.279674] Subtest psrhdr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [617.399740] [124/156] (405s left) kms_plane_multiple (tiling-4) [617.501303] Starting subtest: tiling-4 [617.503265] Starting dynamic subtest: pipe-A-eDP-1 [621.371032] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.870s) [621.382526] Starting dynamic subtest: pipe-B-eDP-1 [625.944217] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.573s) [625.957384] Starting dynamic subtest: pipe-C-eDP-1 [630.509624] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.566s) [630.521315] Starting dynamic subtest: pipe-D-eDP-1 [635.117422] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.604s) [635.119913] Subtest tiling-4: SUCCESS (17.618s) [635.982486] [125/156] (386s left) gem_mmap_gtt (isolation) [636.040338] Subtest isolation: SKIP (0.000s) [636.096359] [126/156] (386s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt) [636.190103] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt [636.194385] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s) [636.296306] [127/156] (386s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [636.398545] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [637.465311] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (1.068s) [637.588408] [128/156] (385s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [637.685515] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [637.687482] Starting dynamic subtest: pipe-A-eDP-1 [637.805790] Dynamic subtest pipe-A-eDP-1: SKIP (0.123s) [637.819288] Starting dynamic subtest: pipe-B-eDP-1 [639.031363] Dynamic subtest pipe-B-eDP-1: SKIP (1.223s) [639.035888] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (1.348s) [640.294650] [129/156] (382s left) kms_prop_blob (invalid-get-prop-any) [640.343798] Starting subtest: invalid-get-prop-any [640.346054] Subtest invalid-get-prop-any: SUCCESS (0.000s) [640.452318] [130/156] (382s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt) [640.557564] Starting subtest: psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt [640.561765] Subtest psrhdr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [640.663864] [131/156] (382s left) gem_exec_nop (basic-sequential) [640.730012] Starting subtest: basic-sequential [655.512908] Subtest basic-sequential: SUCCESS (14.795s) [655.744610] [132/156] (367s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [655.849255] Starting subtest: ccs-on-another-bo-y-tiled-ccs [655.851729] Starting dynamic subtest: pipe-A-eDP-1 [655.874878] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [655.888198] Starting dynamic subtest: pipe-B-eDP-1 [655.910156] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [655.920707] Starting dynamic subtest: pipe-C-eDP-1 [655.942504] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [655.952665] Starting dynamic subtest: pipe-D-eDP-1 [655.974673] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [655.979049] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.004s) [658.092168] [133/156] (365s left) sysfs_defaults (readonly) [658.153133] Starting subtest: readonly [658.155426] Starting dynamic subtest: vecs0 [658.157740] Dynamic subtest vecs0: SUCCESS (0.000s) [658.169065] Starting dynamic subtest: ccs0 [658.170970] Dynamic subtest ccs0: SUCCESS (0.000s) [658.181530] Starting dynamic subtest: vcs0 [658.183402] Dynamic subtest vcs0: SUCCESS (0.000s) [658.193600] Starting dynamic subtest: bcs0 [658.195626] Dynamic subtest bcs0: SUCCESS (0.000s) [658.206437] Starting dynamic subtest: rcs0 [658.208663] Dynamic subtest rcs0: SUCCESS (0.000s) [658.219411] Starting dynamic subtest: vcs1 [658.221332] Dynamic subtest vcs1: SUCCESS (0.000s) [658.223241] Subtest readonly: SUCCESS (0.006s) [658.275412] [134/156] (364s left) syncobj_timeline (multi-wait-for-submit-submitted-signaled) [658.336710] Starting subtest: multi-wait-for-submit-submitted-signaled [658.338765] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s) [658.446612] [135/156] (364s left) gem_ctx_bad_destroy (invalid-pad) [658.500510] Starting subtest: invalid-pad [658.502893] Subtest invalid-pad: SUCCESS (0.000s) [658.577021] [136/156] (364s left) api_intel_bb (object-reloc-keep-cache) [658.622760] Starting subtest: object-reloc-keep-cache [658.627225] Subtest object-reloc-keep-cache: SKIP (0.003s) [658.734367] [137/156] (364s left) syncobj_wait (multi-wait-for-submit-signaled) [658.789397] Starting subtest: multi-wait-for-submit-signaled [658.791699] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [658.891085] [138/156] (364s left) gem_exec_schedule (reorder-wide) [659.066919] Subtest reorder-wide: SKIP (0.000s) [659.245037] [139/156] (364s left) kms_feature_discovery (display-4x) [659.337556] Starting subtest: display-4x [659.341575] Subtest display-4x: SKIP (0.000s) [659.410013] [140/156] (364s left) kms_frontbuffer_tracking (hdr-1p-primscrn-spr-indfb-draw-mmap-wc) [659.506985] Starting subtest: hdr-1p-primscrn-spr-indfb-draw-mmap-wc [659.510916] Subtest hdr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [659.586755] [141/156] (363s left) kms_flip (blocking-wf_vblank) [659.672925] Starting subtest: blocking-wf_vblank [659.675061] Starting dynamic subtest: A-eDP1 [668.585495] Dynamic subtest A-eDP1: SUCCESS (8.912s) [668.599044] Starting dynamic subtest: B-eDP1 [677.491914] Dynamic subtest B-eDP1: SUCCESS (8.907s) [677.507990] Starting dynamic subtest: C-eDP1 [686.379697] Dynamic subtest C-eDP1: SUCCESS (8.884s) [686.394700] Starting dynamic subtest: D-eDP1 [695.279321] Dynamic subtest D-eDP1: SUCCESS (8.895s) [695.282023] Subtest blocking-wf_vblank: SUCCESS (35.609s) [696.485297] [142/156] (327s left) perf_pmu (busy-idle-no-semaphores) [696.526738] Starting subtest: busy-idle-no-semaphores [696.529121] Starting dynamic subtest: rcs0 [697.183123] Dynamic subtest rcs0: SUCCESS (0.655s) [697.195110] Starting dynamic subtest: bcs0 [697.835199] Dynamic subtest bcs0: SUCCESS (0.649s) [697.848876] Starting dynamic subtest: vcs0 [698.488137] Dynamic subtest vcs0: SUCCESS (0.650s) [698.501369] Starting dynamic subtest: vcs1 [699.651466] Dynamic subtest vcs1: SUCCESS (1.159s) [699.664176] Starting dynamic subtest: vecs0 [701.635624] Dynamic subtest vecs0: SUCCESS (1.981s) [701.647632] Starting dynamic subtest: ccs0 [703.620745] Dynamic subtest ccs0: SUCCESS (1.983s) [703.623863] Subtest busy-idle-no-semaphores: SUCCESS (7.092s) [703.738082] [143/156] (319s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [703.845677] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [703.849839] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [703.937420] [144/156] (319s left) kms_legacy_colorkey (invalid-plane) [704.040663] Starting subtest: invalid-plane [704.043022] Starting dynamic subtest: zero-id [704.045193] Dynamic subtest zero-id: SUCCESS (0.000s) [704.056210] Starting dynamic subtest: outrange-id [704.058085] Dynamic subtest outrange-id: SUCCESS (0.000s) [704.059944] Subtest invalid-plane: SUCCESS (0.001s) [704.118523] [145/156] (319s left) gem_exec_reloc (basic-wc-cpu-noreloc) [704.180324] Subtest basic-wc-cpu-noreloc: SKIP (0.000s) [704.246544] [146/156] (319s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [704.353346] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [704.357805] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [704.455199] [147/156] (319s left) gem_mmap_gtt (hang) [704.519998] Subtest hang: SKIP (0.000s) [704.587572] [148/156] (319s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [704.684642] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [704.696608] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [704.777501] [149/156] (319s left) gem_fence_thrash (bo-copy) [704.815645] Starting subtest: bo-copy [704.842933] Subtest bo-copy: SKIP (0.025s) [704.904359] [150/156] (318s left) kms_addfb_basic (framebuffer-vs-set-tiling) [704.954017] Starting subtest: framebuffer-vs-set-tiling [704.957416] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [705.075265] [151/156] (318s left) kms_flip (plain-flip-interruptible) [705.164731] Starting subtest: plain-flip-interruptible [705.166855] Starting dynamic subtest: A-eDP1 [706.841879] Dynamic subtest A-eDP1: SUCCESS (1.675s) [706.858179] Starting dynamic subtest: B-eDP1 [708.544562] Dynamic subtest B-eDP1: SUCCESS (1.699s) [708.557849] Starting dynamic subtest: C-eDP1 [710.232125] Dynamic subtest C-eDP1: SUCCESS (1.685s) [710.245261] Starting dynamic subtest: D-eDP1 [711.833934] Dynamic subtest D-eDP1: SUCCESS (1.600s) [711.839388] Subtest plain-flip-interruptible: SUCCESS (6.672s) [713.086046] [152/156] (310s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt) [713.197474] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt [713.201485] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s) [713.318182] [153/156] (310s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-pwrite) [713.413867] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-pwrite [720.335779] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (6.927s) [720.473658] [154/156] (303s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [720.577135] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [725.944741] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.371s) [727.088532] [155/156] (296s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-move) [727.182050] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-move [727.186546] Subtest fbcpsr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [727.307050] [156/156] (296s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-fullscreen) [727.423741] Starting subtest: psr-1p-primscrn-spr-indfb-fullscreen [734.111013] Subtest psr-1p-primscrn-spr-indfb-fullscreen: SUCCESS (6.692s) [734.224273] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: kms_flip_scaled_crc results: parsing output: 2/ for test: gem_exec_params results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_cursor_crc results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: i915_power results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_flip results: parsing output: 11/ for test: perf_pmu results: parsing output: 12/ for test: kms_content_protection results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_big_fb results: parsing output: 15/ for test: kms_plane_scaling results: parsing output: 16/ for test: prime_busy results: parsing output: 17/ for test: gem_close_race results: parsing output: 18/ for test: kms_frontbuffer_tracking results: parsing output: 19/ for test: kms_cursor_crc results: parsing output: 20/ for test: kms_debugfs results: parsing output: 21/ for test: kms_psr results: parsing output: 22/ for test: gem_workarounds results: parsing output: 23/ for test: gem_render_copy results: parsing output: 24/ for test: gem_flink_race results: parsing output: 25/ for test: i915_module_load results: parsing output: 26/ for test: kms_psr2_sf results: parsing output: 27/ for test: drm_read results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: api_intel_bb results: parsing output: 30/ for test: gem_mmap_gtt results: parsing output: 31/ for test: kms_hdr results: parsing output: 32/ for test: gem_fence_thrash results: parsing output: 33/ for test: kms_ccs results: parsing output: 34/ for test: kms_frontbuffer_tracking results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_pm_dc results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: kms_frontbuffer_tracking results: parsing output: 39/ for test: kms_universal_plane results: parsing output: 40/ for test: gem_pread results: parsing output: 41/ for test: kms_chamelium_edid results: parsing output: 42/ for test: kms_hdmi_inject results: parsing output: 43/ for test: syncobj_timeline results: parsing output: 44/ for test: gem_exec_reloc results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_lmem_swapping results: parsing output: 49/ for test: drm_read results: parsing output: 50/ for test: gem_exec_schedule results: parsing output: 51/ for test: fbdev results: parsing output: 52/ for test: kms_pipe_crc_basic results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: gem_ctx_shared results: parsing output: 55/ for test: gem_mmap_gtt results: parsing output: 56/ for test: gem_wait results: parsing output: 57/ for test: gem_ctx_engines results: parsing output: 58/ for test: gem_ctx_persistence results: parsing output: 59/ for test: kms_pwrite_crc results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_flip results: parsing output: 62/ for test: gem_exec_balancer results: parsing output: 63/ for test: kms_chamelium_hpd results: parsing output: 64/ for test: core_auth results: parsing output: 65/ for test: kms_busy results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: kms_color_pipeline results: parsing output: 69/ for test: gem_mmap_gtt results: parsing output: 70/ for test: kms_ccs results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_render_copy results: parsing output: 73/ for test: gem_mmap_gtt results: parsing output: 74/ for test: gem_set_tiling_vs_blt results: parsing output: 75/ for test: gem_softpin results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_exec_whisper results: parsing output: 78/ for test: kms_rotation_crc results: parsing output: 79/ for test: kms_frontbuffer_tracking results: parsing output: 80/ for test: kms_vrr results: parsing output: 81/ for test: gem_exec_fence results: parsing output: 82/ for test: kms_ccs results: parsing output: 83/ for test: kms_async_flips results: parsing output: 84/ for test: gem_exec_suspend results: parsing output: 85/ for test: gem_ctx_isolation results: parsing output: 86/ for test: kms_big_fb results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_cursor_crc results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: gem_mmap results: parsing output: 91/ for test: kms_big_fb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: syncobj_wait results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: kms_frontbuffer_tracking results: parsing output: 98/ for test: kms_psr results: parsing output: 99/ for test: syncobj_timeline results: parsing output: 100/ for test: gem_softpin results: parsing output: 101/ for test: kms_addfb_basic results: parsing output: 102/ for test: gem_exec_schedule results: parsing output: 103/ for test: core_setmaster results: parsing output: 104/ for test: kms_frontbuffer_tracking results: parsing output: 105/ for test: kms_plane_scaling results: parsing output: 106/ for test: gem_exec_fence results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: syncobj_timeline results: parsing output: 109/ for test: kms_flip_scaled_crc results: parsing output: 110/ for test: kms_lease results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: gem_render_copy_redux results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_psr results: parsing output: 115/ for test: gem_render_copy results: parsing output: 116/ for test: gen7_exec_parse results: parsing output: 117/ for test: i915_drm_fdinfo results: parsing output: 118/ for test: i915_pm_rc6_residency results: parsing output: 119/ for test: syncobj_wait results: parsing output: 120/ for test: kms_plane results: parsing output: 121/ for test: kms_frontbuffer_tracking results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_plane_multiple results: parsing output: 124/ for test: gem_mmap_gtt results: parsing output: 125/ for test: kms_frontbuffer_tracking results: parsing output: 126/ for test: kms_big_fb results: parsing output: 127/ for test: kms_psr2_sf results: parsing output: 128/ for test: kms_prop_blob results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: gem_exec_nop results: parsing output: 131/ for test: kms_ccs results: parsing output: 132/ for test: sysfs_defaults results: parsing output: 133/ for test: syncobj_timeline results: parsing output: 134/ for test: gem_ctx_bad_destroy results: parsing output: 135/ for test: api_intel_bb results: parsing output: 136/ for test: syncobj_wait results: parsing output: 137/ for test: gem_exec_schedule results: parsing output: 138/ for test: kms_feature_discovery results: parsing output: 139/ for test: kms_frontbuffer_tracking results: parsing output: 140/ for test: kms_flip results: parsing output: 141/ for test: perf_pmu results: parsing output: 142/ for test: kms_frontbuffer_tracking results: parsing output: 143/ for test: kms_legacy_colorkey results: parsing output: 144/ for test: gem_exec_reloc results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: gem_mmap_gtt results: parsing output: 147/ for test: kms_flip results: parsing output: 148/ for test: gem_fence_thrash results: parsing output: 149/ for test: kms_addfb_basic results: parsing output: 150/ for test: kms_flip results: parsing output: 151/ for test: kms_frontbuffer_tracking results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: kms_frontbuffer_tracking Done.