[59.763574] Initializing watchdogs [59.763664] /dev/watchdog0 [59.779768] [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.784329] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.786767] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.790035] [001/133] (960s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled) [59.873483] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled [59.877608] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s) [60.073926] [002/133] (960s left) gem_wait (wait) [60.136063] Starting subtest: wait [60.138711] Starting dynamic subtest: all-engines [61.911346] Dynamic subtest all-engines: SUCCESS (1.764s) [61.923693] Starting dynamic subtest: rcs0 [62.959321] Dynamic subtest rcs0: SUCCESS (1.043s) [62.969401] Starting dynamic subtest: bcs0 [64.006943] Dynamic subtest bcs0: SUCCESS (1.041s) [64.017407] Starting dynamic subtest: vcs0 [65.052568] Dynamic subtest vcs0: SUCCESS (1.041s) [65.063559] Starting dynamic subtest: vcs1 [66.102854] Dynamic subtest vcs1: SUCCESS (1.046s) [66.116868] Starting dynamic subtest: vecs0 [67.198589] Dynamic subtest vecs0: SUCCESS (1.092s) [67.207002] Starting dynamic subtest: ccs0 [68.247902] Dynamic subtest ccs0: SUCCESS (1.046s) [68.250883] Subtest wait: SUCCESS (8.081s) [68.448469] [003/133] (951s left) gem_readwrite (read-write) [68.497414] Subtest read-write: SKIP (0.000s) [68.561445] [004/133] (951s left) kms_big_fb (linear-16bpp-rotate-270) [68.673923] Starting subtest: linear-16bpp-rotate-270 [68.711080] Subtest linear-16bpp-rotate-270: SKIP (0.037s) [68.826787] [005/133] (951s left) kms_plane (pixel-format-4-tiled-modifier-source-clamping) [68.922887] Starting subtest: pixel-format-4-tiled-modifier-source-clamping [68.949991] Starting dynamic subtest: pipe-A-plane-0 [69.573221] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s) [69.582536] Starting dynamic subtest: pipe-A-plane-3 [70.007195] Dynamic subtest pipe-A-plane-3: SUCCESS (0.432s) [71.129692] Starting dynamic subtest: pipe-B-plane-0 [71.745814] Dynamic subtest pipe-B-plane-0: SUCCESS (0.622s) [71.756409] Starting dynamic subtest: pipe-B-plane-3 [72.179150] Dynamic subtest pipe-B-plane-3: SUCCESS (0.433s) [72.490245] Subtest pixel-format-4-tiled-modifier-source-clamping: SUCCESS (3.562s) [73.322889] [006/133] (947s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [73.441415] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [73.445836] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [73.528674] [007/133] (947s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [73.621116] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [73.625708] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [73.710583] [008/133] (946s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [73.801660] Starting subtest: plane-downscale-factor-0-5-with-modifiers [73.804046] Starting dynamic subtest: pipe-A [73.823700] Dynamic subtest pipe-A: SKIP (0.016s) [73.832254] Starting dynamic subtest: pipe-B [73.852341] Dynamic subtest pipe-B: SKIP (0.029s) [73.860164] Starting dynamic subtest: pipe-C [73.886527] Dynamic subtest pipe-C: SKIP (0.033s) [73.894152] Starting dynamic subtest: pipe-D [73.920278] Dynamic subtest pipe-D: SKIP (0.034s) [73.923984] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.113s) [74.023818] [009/133] (946s left) gem_wait (invalid-buf) [74.091940] Starting subtest: invalid-buf [74.094380] Subtest invalid-buf: SUCCESS (0.000s) [74.292216] [010/133] (946s left) kms_flip (2x-dpms-vs-vblank-race) [74.391093] Starting subtest: 2x-dpms-vs-vblank-race [74.400287] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [74.477999] [011/133] (946s left) perf_pmu (busy-check-all) [74.518717] Starting subtest: busy-check-all [74.520587] Starting dynamic subtest: rcs0 [75.069678] Dynamic subtest rcs0: SUCCESS (0.551s) [75.082573] Starting dynamic subtest: bcs0 [75.619954] Dynamic subtest bcs0: SUCCESS (0.549s) [75.630884] Starting dynamic subtest: vcs0 [76.886661] Dynamic subtest vcs0: SUCCESS (1.263s) [76.897840] Starting dynamic subtest: vcs1 [78.870604] Dynamic subtest vcs1: SUCCESS (1.981s) [78.881817] Starting dynamic subtest: vecs0 [80.918903] Dynamic subtest vecs0: SUCCESS (2.046s) [80.929912] Starting dynamic subtest: ccs0 [81.475769] Dynamic subtest ccs0: SUCCESS (0.557s) [81.478975] Subtest busy-check-all: SUCCESS (6.953s) [81.565231] [012/133] (939s left) gem_exec_fence (basic-busy-all) [81.631546] Starting subtest: basic-busy-all [81.732980] Subtest basic-busy-all: SUCCESS (0.102s) [84.002103] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [84.005226] [013/133] (936s left) kms_atomic_interruptible (legacy-cursor) [84.097992] Starting subtest: legacy-cursor [84.100337] Starting dynamic subtest: pipe-A-eDP-1 [91.537839] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.435s) [91.539807] Subtest legacy-cursor: SUCCESS (7.435s) [92.386982] [014/133] (928s left) syncobj_wait (reset-during-wait-for-submit) [92.449671] Starting subtest: reset-during-wait-for-submit [92.555242] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [92.643990] [015/133] (928s left) kms_content_protection (dp-mst-type-0-hdcp14) [92.787704] Starting subtest: dp-mst-type-0-hdcp14 [92.792035] Subtest dp-mst-type-0-hdcp14: SKIP (0.000s) [92.908319] [016/133] (927s left) kms_frontbuffer_tracking (fbc-2p-pri-indfb-multidraw) [93.010417] Starting subtest: fbc-2p-pri-indfb-multidraw [93.014603] Subtest fbc-2p-pri-indfb-multidraw: SKIP (0.000s) [93.103957] [017/133] (927s left) core_auth (many-magics) [93.162270] Starting subtest: many-magics [93.942712] Subtest many-magics: SUCCESS (0.783s) [94.182571] [018/133] (926s left) gem_exec_schedule (u-submit-late-slice) [94.249781] Starting subtest: u-submit-late-slice [94.251774] Starting dynamic subtest: rcs0 [94.284596] Dynamic subtest rcs0: SUCCESS (0.039s) [94.296088] Starting dynamic subtest: bcs0 [94.316998] Dynamic subtest bcs0: SUCCESS (0.032s) [94.328184] Starting dynamic subtest: vcs0 [94.350281] Dynamic subtest vcs0: SUCCESS (0.033s) [94.358371] Starting dynamic subtest: vcs1 [94.386194] Dynamic subtest vcs1: SUCCESS (0.036s) [94.394973] Starting dynamic subtest: vecs0 [94.415853] Dynamic subtest vecs0: SUCCESS (0.029s) [94.427870] Starting dynamic subtest: ccs0 [94.445136] Dynamic subtest ccs0: SUCCESS (0.029s) [94.447041] Subtest u-submit-late-slice: SUCCESS (0.200s) [95.982459] [019/133] (925s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [96.081637] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [97.126868] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.046s) [97.261903] [020/133] (923s left) kms_ccs (bad-aux-stride-4-tiled-mtl-mc-ccs) [97.369475] Starting subtest: bad-aux-stride-4-tiled-mtl-mc-ccs [97.371181] Starting dynamic subtest: pipe-A-eDP-1 [97.431956] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.064s) [97.441668] Starting dynamic subtest: pipe-B-eDP-1 [97.514348] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.082s) [97.522466] Starting dynamic subtest: pipe-C-eDP-1 [97.577985] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.063s) [97.586897] Starting dynamic subtest: pipe-D-eDP-1 [97.641777] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.063s) [97.643736] Subtest bad-aux-stride-4-tiled-mtl-mc-ccs: SUCCESS (0.275s) [99.959785] [021/133] (921s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [100.058061] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [106.669320] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SUCCESS (6.613s) [106.792877] [022/133] (914s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip) [106.894646] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip [107.552266] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s) [107.736946] [023/133] (913s left) gem_exec_schedule (out-order) [107.816943] Starting subtest: out-order [107.819240] Starting dynamic subtest: rcs0 [107.908128] Dynamic subtest rcs0: SUCCESS (0.099s) [107.918918] Starting dynamic subtest: vcs0 [107.993794] Dynamic subtest vcs0: SUCCESS (0.085s) [108.006599] Starting dynamic subtest: vcs1 [108.074801] Dynamic subtest vcs1: SUCCESS (0.081s) [108.085544] Starting dynamic subtest: vecs0 [108.150422] Dynamic subtest vecs0: SUCCESS (0.075s) [108.162503] Starting dynamic subtest: ccs0 [108.230860] Dynamic subtest ccs0: SUCCESS (0.080s) [108.233618] Subtest out-order: SUCCESS (0.422s) [110.004163] [024/133] (911s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-wc) [110.097355] Starting subtest: psr-rgb101010-draw-mmap-wc [117.172079] Subtest psr-rgb101010-draw-mmap-wc: SUCCESS (7.076s) [117.263129] [025/133] (903s left) syncobj_timeline (etime-single-wait-submitted) [117.317935] Starting subtest: etime-single-wait-submitted [117.427531] Subtest etime-single-wait-submitted: SUCCESS (0.109s) [117.500317] [026/133] (903s left) kms_prop_blob (blob-prop-lifetime) [117.554546] Starting subtest: blob-prop-lifetime [117.556593] Subtest blob-prop-lifetime: SUCCESS (0.001s) [117.664324] [027/133] (903s left) gem_ctx_param (basic) [117.729862] Starting subtest: basic [117.732888] Subtest basic: SUCCESS (0.001s) [117.868894] [028/133] (903s left) sw_sync (sync_busy) [117.919032] Starting subtest: sync_busy [117.921205] Subtest sync_busy: SUCCESS (0.002s) [117.991373] [029/133] (903s left) api_intel_allocator (two-level-inception) [118.050815] Starting subtest: two-level-inception [123.454020] Subtest two-level-inception: SUCCESS (5.405s) [123.574874] [030/133] (897s left) i915_query (engine-info-invalid) [123.643656] Starting subtest: engine-info-invalid [123.645959] Subtest engine-info-invalid: SUCCESS (0.000s) [123.766243] [031/133] (897s left) kms_cursor_crc (cursor-offscreen-64x64) [123.950411] Starting subtest: cursor-offscreen-64x64 [123.955139] Starting dynamic subtest: pipe-A-eDP-1 [125.906507] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.951s) [125.934785] Starting dynamic subtest: pipe-D-eDP-1 [128.561098] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.634s) [128.563292] Subtest cursor-offscreen-64x64: SUCCESS (4.610s) [129.413676] [032/133] (892s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip) [129.525322] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip [129.530062] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s) [129.621066] [033/133] (892s left) sw_sync (sync_multi_consumer_producer) [129.653614] Starting subtest: sync_multi_consumer_producer [129.948054] Subtest sync_multi_consumer_producer: SUCCESS (0.296s) [130.008472] [034/133] (891s left) perf_pmu (busy-idle-check-all) [130.046721] Starting subtest: busy-idle-check-all [130.048764] Starting dynamic subtest: rcs0 [130.696618] Dynamic subtest rcs0: SUCCESS (0.651s) [130.708044] Starting dynamic subtest: bcs0 [131.347655] Dynamic subtest bcs0: SUCCESS (0.650s) [131.358802] Starting dynamic subtest: vcs0 [132.886901] Dynamic subtest vcs0: SUCCESS (1.536s) [132.898278] Starting dynamic subtest: vcs1 [134.870608] Dynamic subtest vcs1: SUCCESS (1.982s) [134.882526] Starting dynamic subtest: vecs0 [136.918882] Dynamic subtest vecs0: SUCCESS (2.046s) [136.930414] Starting dynamic subtest: ccs0 [137.575100] Dynamic subtest ccs0: SUCCESS (0.656s) [137.577595] Subtest busy-idle-check-all: SUCCESS (7.530s) [137.681530] [035/133] (884s left) kms_psr (fbc-pr-sprite-render) [137.780860] Starting subtest: fbc-pr-sprite-render [137.785259] Subtest fbc-pr-sprite-render: SKIP (0.000s) [137.857246] [036/133] (883s left) core_getstats (basic) [137.911831] Starting subtest: basic [137.913764] Subtest basic: SUCCESS (0.000s) [138.004191] [037/133] (883s left) gem_mmap_gtt (basic-small-copy-odd) [138.056753] Subtest basic-small-copy-odd: SKIP (0.000s) [138.113163] [038/133] (883s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-render) [138.204058] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-render [145.449785] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-render: SUCCESS (7.248s) [145.595780] [039/133] (876s left) prime_vgem (coherency-gtt) [145.665158] Starting subtest: coherency-gtt [145.669806] Subtest coherency-gtt: SKIP (0.000s) [145.752822] [040/133] (876s left) syncobj_wait (invalid-multi-wait-unsubmitted) [145.817344] Starting subtest: invalid-multi-wait-unsubmitted [145.819654] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [145.938327] [041/133] (876s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [146.034700] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [146.039065] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [146.131341] [042/133] (875s left) gem_ctx_persistence (hang) [146.188466] Starting subtest: hang [146.193121] Subtest hang: SKIP (0.000s) [146.289569] [043/133] (875s left) gem_ppgtt (shrink-vs-evict-any) [146.353854] Starting subtest: shrink-vs-evict-any [151.920062] Subtest shrink-vs-evict-any: SUCCESS (5.564s) [152.015531] [044/133] (870s left) gem_ctx_param (invalid-set-ringsize) [152.072090] Starting subtest: invalid-set-ringsize [152.074381] Subtest invalid-set-ringsize: SUCCESS (0.000s) [152.150891] [045/133] (869s left) i915_pm_rpm (gem-pread) [154.077950] Starting subtest: gem-pread [156.132094] Subtest gem-pread: SUCCESS (2.059s) [156.234019] [046/133] (865s left) gem_exec_fence (basic-busy) [156.406038] Starting subtest: basic-busy [156.408537] Starting dynamic subtest: rcs0 [156.489532] Dynamic subtest rcs0: SUCCESS (0.083s) [156.500338] Starting dynamic subtest: bcs0 [156.545491] Dynamic subtest bcs0: SUCCESS (0.054s) [156.556421] Starting dynamic subtest: vcs0 [156.602159] Dynamic subtest vcs0: SUCCESS (0.055s) [156.613076] Starting dynamic subtest: vcs1 [156.659641] Dynamic subtest vcs1: SUCCESS (0.056s) [156.670650] Starting dynamic subtest: vecs0 [156.722339] Dynamic subtest vecs0: SUCCESS (0.061s) [156.733256] Starting dynamic subtest: ccs0 [156.781683] Dynamic subtest ccs0: SUCCESS (0.058s) [156.784242] Subtest basic-busy: SUCCESS (0.377s) [158.963311] [047/133] (863s left) gem_softpin (allocator-evict) [159.025981] Starting subtest: allocator-evict [159.029476] Starting dynamic subtest: rcs0 [183.038151] Dynamic subtest rcs0: SUCCESS (24.010s) [183.049431] Starting dynamic subtest: bcs0 [206.976069] Dynamic subtest bcs0: SUCCESS (23.935s) [206.987834] Starting dynamic subtest: vcs0 [230.543709] Dynamic subtest vcs0: SUCCESS (23.565s) [230.552652] Starting dynamic subtest: vcs1 [254.496049] Dynamic subtest vcs1: SUCCESS (23.949s) [254.505509] Starting dynamic subtest: vecs0 [278.261625] Dynamic subtest vecs0: SUCCESS (23.764s) [278.270538] Starting dynamic subtest: ccs0 [301.935612] Dynamic subtest ccs0: SUCCESS (23.672s) [301.937909] Subtest allocator-evict: SUCCESS (142.901s) [302.018720] [048/133] (720s left) gem_basic (create-fd-close) [302.109865] Starting subtest: create-fd-close [302.114042] Subtest create-fd-close: SUCCESS (0.000s) [302.231938] [049/133] (720s left) kms_vblank (query-busy-hang) [302.324865] Starting subtest: query-busy-hang [302.327055] Starting dynamic subtest: pipe-A-eDP-1 [328.662868] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.336s) [328.677841] Starting dynamic subtest: pipe-D-eDP-1 [343.638717] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.975s) [343.641106] Subtest query-busy-hang: SUCCESS (41.315s) [344.444356] [050/133] (677s left) kms_psr (pr-cursor-render) [344.533052] Starting subtest: pr-cursor-render [344.537372] Subtest pr-cursor-render: SKIP (0.000s) [344.604013] [051/133] (677s left) perf (mi-rpc) [344.750830] Starting subtest: mi-rpc [344.754806] Subtest mi-rpc: SKIP (0.000s) [344.796108] [052/133] (677s left) kms_flip (2x-flip-vs-dpms) [344.886276] Starting subtest: 2x-flip-vs-dpms [344.897601] Subtest 2x-flip-vs-dpms: SKIP (0.011s) [344.982959] [053/133] (677s left) kms_frontbuffer_tracking (psr-rgb565-draw-render) [345.078514] Starting subtest: psr-rgb565-draw-render [352.065339] Subtest psr-rgb565-draw-render: SUCCESS (6.990s) [352.192675] [054/133] (670s left) kms_chamelium_color (degamma) [352.309477] Subtest degamma: SKIP (0.000s) [352.360766] [055/133] (670s left) i915_drm_fdinfo (idle) [352.402445] Starting subtest: idle [352.404460] Starting dynamic subtest: rcs0 [352.956055] Dynamic subtest rcs0: SUCCESS (0.556s) [352.968060] Starting dynamic subtest: bcs0 [353.462757] Dynamic subtest bcs0: SUCCESS (0.503s) [353.472993] Starting dynamic subtest: vcs0 [353.968521] Dynamic subtest vcs0: SUCCESS (0.503s) [353.980518] Starting dynamic subtest: vcs1 [354.474066] Dynamic subtest vcs1: SUCCESS (0.503s) [354.486764] Starting dynamic subtest: vecs0 [354.979621] Dynamic subtest vecs0: SUCCESS (0.503s) [354.991885] Starting dynamic subtest: ccs0 [355.485468] Dynamic subtest ccs0: SUCCESS (0.503s) [355.488340] Subtest idle: SUCCESS (3.085s) [355.569503] [056/133] (667s left) dmabuf_sync_file (import-basic) [355.614910] Starting subtest: import-basic [355.617587] Subtest import-basic: SUCCESS (0.003s) [355.673541] [057/133] (666s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted-signaled) [355.724763] Starting subtest: etime-multi-wait-all-available-unsubmitted-signaled [355.826252] Subtest etime-multi-wait-all-available-unsubmitted-signaled: SUCCESS (0.101s) [355.905541] [058/133] (666s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [356.018151] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [356.022279] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [356.110608] [059/133] (666s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [356.226502] Starting subtest: short-flip-before-cursor-toggle [357.176823] Subtest short-flip-before-cursor-toggle: SUCCESS (0.948s) [358.022738] [060/133] (664s left) kms_big_fb (y-tiled-addfb-size-overflow) [358.128129] Starting subtest: y-tiled-addfb-size-overflow [358.132622] Subtest y-tiled-addfb-size-overflow: SKIP (0.000s) [358.233673] [061/133] (664s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-plflip-blt) [358.330114] Starting subtest: fbc-2p-primscrn-shrfb-plflip-blt [358.334428] Subtest fbc-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [358.428803] [062/133] (664s left) kms_plane_cursor (viewport) [358.526858] Starting subtest: viewport [358.531136] Starting dynamic subtest: pipe-A-eDP-1-size-64 [361.061741] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.535s) [361.121900] Starting dynamic subtest: pipe-A-eDP-1-size-128 [363.569443] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.460s) [363.630366] Starting dynamic subtest: pipe-A-eDP-1-size-256 [366.115505] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.494s) [366.465677] Starting dynamic subtest: pipe-B-eDP-1-size-64 [369.612625] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.158s) [369.679071] Starting dynamic subtest: pipe-B-eDP-1-size-128 [372.136172] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.471s) [372.199577] Starting dynamic subtest: pipe-B-eDP-1-size-256 [374.647578] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.460s) [374.997522] Starting dynamic subtest: pipe-C-eDP-1-size-64 [377.768718] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.782s) [377.806339] Starting dynamic subtest: pipe-C-eDP-1-size-128 [379.889067] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.092s) [379.927339] Starting dynamic subtest: pipe-C-eDP-1-size-256 [382.001503] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.081s) [382.335861] Starting dynamic subtest: pipe-D-eDP-1-size-64 [385.072909] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.753s) [385.111565] Starting dynamic subtest: pipe-D-eDP-1-size-128 [387.230387] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.127s) [387.267603] Starting dynamic subtest: pipe-D-eDP-1-size-256 [389.395520] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.136s) [389.721759] Subtest viewport: SUCCESS (31.194s) [390.552020] [063/133] (632s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu) [390.646727] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu [394.709600] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (4.066s) [395.879688] [064/133] (627s left) gem_workarounds (reset-fd) [395.948883] Starting subtest: reset-fd [396.137610] Subtest reset-fd: SUCCESS (0.189s) [396.250921] [065/133] (626s left) gen3_render_linear_blits [396.369959] [066/133] (626s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [396.458795] Starting subtest: fbc-rgb565-draw-mmap-wc [400.472701] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (4.018s) [401.666976] [067/133] (621s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-cpu) [401.786070] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-cpu [405.383287] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-cpu: SUCCESS (3.601s) [406.557332] [068/133] (616s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling) [406.654320] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling [406.656647] Starting dynamic subtest: pipe-A-default-mode [407.815395] Dynamic subtest pipe-A-default-mode: SKIP (1.160s) [407.819252] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.162s) [407.953469] [069/133] (615s left) syncobj_timeline (invalid-transfer-bad-pad) [408.020074] Starting subtest: invalid-transfer-bad-pad [408.022287] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [408.118255] [070/133] (615s left) syncobj_basic (illegal-fd-to-handle) [408.167256] Starting subtest: illegal-fd-to-handle [408.169514] Subtest illegal-fd-to-handle: SUCCESS (0.000s) [408.262994] [071/133] (614s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-move) [408.353677] Starting subtest: fbc-1p-primscrn-cur-indfb-move [412.447677] Subtest fbc-1p-primscrn-cur-indfb-move: SUCCESS (4.097s) [413.579738] [072/133] (609s left) kms_cursor_crc (cursor-random-256x256) [413.821495] Starting subtest: cursor-random-256x256 [413.823677] Starting dynamic subtest: pipe-A-eDP-1 [417.167621] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.344s) [417.202528] Starting dynamic subtest: pipe-D-eDP-1 [421.179900] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.988s) [421.182079] Subtest cursor-random-256x256: SUCCESS (7.360s) [422.043481] [073/133] (601s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [422.139095] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [422.143233] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [422.232321] [074/133] (601s left) gem_exec_fence (invalid-timeline-fence-array) [422.828985] Starting subtest: invalid-timeline-fence-array [422.835098] Subtest invalid-timeline-fence-array: SUCCESS (0.006s) [423.980227] [075/133] (599s left) kms_chamelium_frames (vga-frame-dump) [424.358789] Subtest vga-frame-dump: SKIP (0.000s) [425.142875] [076/133] (598s left) kms_flip (2x-flip-vs-panning-interruptible) [425.234688] Starting subtest: 2x-flip-vs-panning-interruptible [425.245660] Subtest 2x-flip-vs-panning-interruptible: SKIP (0.011s) [425.322542] [077/133] (598s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [425.426314] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [425.430213] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [425.523089] [078/133] (598s left) gem_create (create-size-update) [425.587396] Starting subtest: create-size-update [425.589635] Subtest create-size-update: SUCCESS (0.000s) [425.800595] [079/133] (597s left) kms_psr (psr2-sprite-plane-move) [425.896956] Starting subtest: psr2-sprite-plane-move [425.899200] Starting dynamic subtest: eDP-1 [427.695574] Dynamic subtest eDP-1: SUCCESS (1.798s) [427.697830] Subtest psr2-sprite-plane-move: SUCCESS (1.799s) [428.549448] [080/133] (595s left) gen7_exec_parse (batch-without-end) [428.609534] Subtest batch-without-end: SKIP (0.000s) [428.680023] [081/133] (594s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled) [428.737862] Starting subtest: multi-wait-for-submit-available-submitted-signaled [428.740230] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.000s) [428.860892] [082/133] (594s left) gem_ppgtt (blt-vs-render-ctxn) [428.915357] Starting subtest: blt-vs-render-ctxN [461.678123] Subtest blt-vs-render-ctxN: SUCCESS (32.758s) [461.808517] [083/133] (561s left) kms_cursor_edge_walk (128x128-top-bottom) [461.931241] Starting subtest: 128x128-top-bottom [461.933597] Starting dynamic subtest: pipe-A-eDP-1 [465.391312] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.459s) [465.405075] Starting dynamic subtest: pipe-D-eDP-1 [468.535805] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.143s) [468.538204] Subtest 128x128-top-bottom: SUCCESS (6.605s) [469.354524] [084/133] (554s left) gem_exec_alignment (forked) [469.424663] Starting subtest: forked [508.722695] Subtest forked: SUCCESS (39.293s) [508.810596] [085/133] (515s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [508.946710] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [508.948811] Starting dynamic subtest: pipe-A-default-mode [511.717944] Dynamic subtest pipe-A-default-mode: SUCCESS (2.769s) [511.719940] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (2.771s) [512.554054] [086/133] (511s left) kms_ccs (bad-rotation-90-yf-tiled-ccs) [512.659072] Starting subtest: bad-rotation-90-yf-tiled-ccs [512.661341] Starting dynamic subtest: pipe-A-eDP-1 [512.685564] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [512.697502] Starting dynamic subtest: pipe-B-eDP-1 [512.719188] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [512.728140] Starting dynamic subtest: pipe-C-eDP-1 [512.750083] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [512.758972] Starting dynamic subtest: pipe-D-eDP-1 [512.780887] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [512.785237] Subtest bad-rotation-90-yf-tiled-ccs: SKIP (0.005s) [514.836224] [087/133] (509s left) kms_psr (psr-primary-page-flip) [514.938945] Starting subtest: psr-primary-page-flip [514.941250] Starting dynamic subtest: eDP-1 [516.646257] Dynamic subtest eDP-1: SUCCESS (1.707s) [516.648606] Subtest psr-primary-page-flip: SUCCESS (1.708s) [517.503889] [088/133] (506s left) kms_psr (fbc-pr-cursor-mmap-cpu) [517.599257] Starting subtest: fbc-pr-cursor-mmap-cpu [517.603198] Subtest fbc-pr-cursor-mmap-cpu: SKIP (0.000s) [517.674969] [089/133] (506s left) kms_flip (2x-plain-flip-ts-check) [517.775310] Starting subtest: 2x-plain-flip-ts-check [517.784408] Subtest 2x-plain-flip-ts-check: SKIP (0.011s) [517.866110] [090/133] (506s left) fbdev (unaligned-read) [517.907382] Starting subtest: unaligned-read [517.920864] Subtest unaligned-read: SUCCESS (0.016s) [517.977718] [091/133] (506s left) gem_pwrite_snooped [518.110672] [092/133] (506s left) kms_color (ctm-green-to-red) [518.205237] Starting subtest: ctm-green-to-red [518.207040] Starting dynamic subtest: pipe-A-eDP-1 [518.925194] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.719s) [518.935373] Starting dynamic subtest: pipe-B-eDP-1 [520.276053] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.350s) [520.287832] Starting dynamic subtest: pipe-C-eDP-1 [521.558075] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.280s) [521.576963] Starting dynamic subtest: pipe-D-eDP-1 [522.925615] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.368s) [522.927770] Subtest ctm-green-to-red: SUCCESS (4.721s) [523.742632] [093/133] (500s left) gem_exec_schedule (u-semaphore-codependency) [523.829745] Starting subtest: u-semaphore-codependency [523.834656] Subtest u-semaphore-codependency: SUCCESS (0.013s) [524.172579] [094/133] (500s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [524.234276] Starting subtest: x-tiled-to-vebox-y-tiled [524.238884] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [524.415297] [095/133] (499s left) gem_exec_balancer (bonded-sync) [524.482922] Starting subtest: bonded-sync [524.487566] Subtest bonded-sync: SKIP (0.000s) [524.795754] [096/133] (499s left) kms_big_fb (linear-max-hw-stride-64bpp-rotate-180) [524.902252] Starting subtest: linear-max-hw-stride-64bpp-rotate-180 [526.037309] Subtest linear-max-hw-stride-64bpp-rotate-180: SUCCESS (1.136s) [526.178589] [097/133] (498s left) sysfs_heartbeat_interval (invalid) [526.242492] Starting subtest: invalid [526.244422] Starting dynamic subtest: vecs0 [526.246264] Dynamic subtest vecs0: SUCCESS (0.000s) [526.256055] Starting dynamic subtest: ccs0 [526.257826] Dynamic subtest ccs0: SUCCESS (0.000s) [526.266832] Starting dynamic subtest: vcs0 [526.268381] Dynamic subtest vcs0: SUCCESS (0.000s) [526.277246] Starting dynamic subtest: bcs0 [526.278778] Dynamic subtest bcs0: SUCCESS (0.000s) [526.287669] Starting dynamic subtest: rcs0 [526.289193] Dynamic subtest rcs0: SUCCESS (0.000s) [526.297536] Starting dynamic subtest: vcs1 [526.299507] Dynamic subtest vcs1: SUCCESS (0.000s) [526.301176] Subtest invalid: SUCCESS (0.006s) [526.356260] [098/133] (498s left) kms_getfb (getfb-handle-protection) [526.455244] Starting subtest: getfb-handle-protection [526.470124] Subtest getfb-handle-protection: SUCCESS (0.017s) [526.572874] [099/133] (497s left) kms_invalid_mode (bad-vsync-end) [526.676348] Starting subtest: bad-vsync-end [526.678231] Starting dynamic subtest: pipe-A-eDP-1 [526.959898] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s) [526.970504] Starting dynamic subtest: pipe-B-eDP-1 [526.972472] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [526.981556] Starting dynamic subtest: pipe-C-eDP-1 [526.983897] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [526.993349] Starting dynamic subtest: pipe-D-eDP-1 [526.995600] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [526.997855] Subtest bad-vsync-end: SUCCESS (0.292s) [527.769614] [100/133] (496s left) kms_atomic (atomic-plane-damage) [527.882151] Starting subtest: atomic-plane-damage [527.952462] Starting dynamic subtest: pipe-A-eDP-1 [528.527139] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.577s) [528.529457] Subtest atomic-plane-damage: SUCCESS (0.646s) [529.401685] [101/133] (495s left) kms_lease (page-flip-implicit-plane) [529.489948] Starting subtest: page-flip-implicit-plane [529.492240] Starting dynamic subtest: pipe-A-eDP-1 [529.978074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.487s) [529.988355] Starting dynamic subtest: pipe-B-eDP-1 [531.139281] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.161s) [531.149950] Starting dynamic subtest: pipe-C-eDP-1 [532.255372] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s) [532.265083] Starting dynamic subtest: pipe-D-eDP-1 [533.391766] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [533.394209] Subtest page-flip-implicit-plane: SUCCESS (3.903s) [534.220249] [102/133] (490s left) gem_exercise_blt (fast-copy) [534.273317] Starting subtest: fast-copy [534.275549] Starting dynamic subtest: linear-smem-smem [534.295105] Dynamic subtest linear-smem-smem: SUCCESS (0.021s) [534.306558] Starting dynamic subtest: xmajor-smem-smem [534.313161] Dynamic subtest xmajor-smem-smem: SUCCESS (0.018s) [534.322692] Starting dynamic subtest: tile4-smem-smem [534.329912] Dynamic subtest tile4-smem-smem: SUCCESS (0.016s) [534.339359] Starting dynamic subtest: tile64-smem-smem [534.347643] Dynamic subtest tile64-smem-smem: SUCCESS (0.017s) [534.349833] Subtest fast-copy: SUCCESS (0.075s) [534.467464] [103/133] (490s left) kms_flip (flip-vs-fences) [534.556276] Starting subtest: flip-vs-fences [534.560591] Subtest flip-vs-fences: SKIP (0.000s) [534.659066] [104/133] (489s left) kms_ccs (crc-sprite-planes-basic-yf-tiled-ccs) [534.753210] Starting subtest: crc-sprite-planes-basic-yf-tiled-ccs [534.755416] Starting dynamic subtest: pipe-A-eDP-1 [534.811682] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [534.820916] Starting dynamic subtest: pipe-B-eDP-1 [534.877208] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [534.888177] Starting dynamic subtest: pipe-C-eDP-1 [534.945295] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [534.955496] Starting dynamic subtest: pipe-D-eDP-1 [535.012944] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [535.016974] Subtest crc-sprite-planes-basic-yf-tiled-ccs: SKIP (0.009s) [536.992282] [105/133] (487s left) gem_exec_reloc (basic-scanout) [537.060335] Subtest basic-scanout: SKIP (0.000s) [537.130772] [106/133] (487s left) kms_addfb_basic (legacy-format) [537.178961] Starting subtest: legacy-format [537.201077] Subtest legacy-format: SUCCESS (0.022s) [537.327058] [107/133] (487s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [537.422563] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [537.426313] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [537.526751] [108/133] (487s left) kms_frontbuffer_tracking (fbcpsr-2p-shrfb-fliptrack-mmap-gtt) [537.629302] Starting subtest: fbcpsr-2p-shrfb-fliptrack-mmap-gtt [537.633720] Subtest fbcpsr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [537.728582] [109/133] (487s left) kms_getfb (getfb-repeated-different-handles) [537.830314] Starting subtest: getfb-repeated-different-handles [537.832605] Subtest getfb-repeated-different-handles: SUCCESS (0.000s) [537.936508] [110/133] (486s left) kms_vblank (ts-continuation-modeset-hang) [538.040051] Starting subtest: ts-continuation-modeset-hang [538.041922] Starting dynamic subtest: pipe-A-eDP-1 [564.695325] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.653s) [564.709678] Starting dynamic subtest: pipe-D-eDP-1 [589.657787] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.961s) [589.660776] Subtest ts-continuation-modeset-hang: SUCCESS (51.619s) [590.505829] [111/133] (434s left) gem_lmem_swapping (random) [590.558397] Subtest random: SKIP (0.000s) [590.601528] [112/133] (434s left) syncobj_wait (multi-wait-for-submit-submitted) [590.654181] Starting subtest: multi-wait-for-submit-submitted [590.762921] Subtest multi-wait-for-submit-submitted: SUCCESS (0.109s) [590.848067] [113/133] (434s left) kms_pm_rpm (universal-planes-dpms) [593.080034] Starting subtest: universal-planes-dpms [593.082613] Starting dynamic subtest: plane-35 [601.516300] Dynamic subtest plane-35: SUCCESS (8.438s) [601.528406] Starting dynamic subtest: plane-65 [609.801911] Dynamic subtest plane-65: SUCCESS (8.284s) [609.814101] Starting dynamic subtest: plane-95 [618.128754] Dynamic subtest plane-95: SUCCESS (8.325s) [618.141572] Starting dynamic subtest: plane-125 [626.451790] Dynamic subtest plane-125: SUCCESS (8.321s) [626.463484] Starting dynamic subtest: plane-135 [634.783559] Dynamic subtest plane-135: SUCCESS (8.329s) [634.795438] Starting dynamic subtest: plane-145 [643.296708] Dynamic subtest plane-145: SUCCESS (8.510s) [643.299635] Subtest universal-planes-dpms: SUCCESS (50.220s) [643.702736] [114/133] (381s left) prime_busy (before-wait) [643.766919] Starting subtest: before-wait [643.769235] Starting dynamic subtest: rcs0 [643.791670] Dynamic subtest rcs0: SUCCESS (0.024s) [643.803209] Starting dynamic subtest: bcs0 [643.830603] Dynamic subtest bcs0: SUCCESS (0.039s) [643.840637] Starting dynamic subtest: vcs0 [643.871998] Dynamic subtest vcs0: SUCCESS (0.041s) [643.881641] Starting dynamic subtest: vcs1 [643.913821] Dynamic subtest vcs1: SUCCESS (0.041s) [643.923852] Starting dynamic subtest: vecs0 [643.954745] Dynamic subtest vecs0: SUCCESS (0.040s) [643.964275] Starting dynamic subtest: ccs0 [643.995745] Dynamic subtest ccs0: SUCCESS (0.040s) [644.105075] Subtest before-wait: SUCCESS (0.339s) [644.182413] [115/133] (380s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-onoff) [644.286695] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-onoff [644.290841] Subtest fbcpsr-2p-primscrn-spr-indfb-onoff: SKIP (0.000s) [644.392281] [116/133] (380s left) kms_pm_backlight (fade-with-suspend) [644.485116] Starting subtest: fade-with-suspend [660.696314] Starting dynamic subtest: eDP-1 [663.161697] Dynamic subtest eDP-1: SUCCESS (2.468s) [663.163964] Subtest fade-with-suspend: SUCCESS (4.905s) [673.026143] [117/133] (361s left) kms_cursor_legacy (2x-cursor-vs-flip-legacy) [673.172420] Starting subtest: 2x-cursor-vs-flip-legacy [673.177034] Subtest 2x-cursor-vs-flip-legacy: SKIP (0.001s) [673.327504] [118/133] (360s left) kms_rotation_crc (sprite-rotation-270) [673.415473] Starting subtest: sprite-rotation-270 [673.419992] Subtest sprite-rotation-270: SKIP (0.001s) [673.495373] [119/133] (360s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt) [673.590526] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt [673.594886] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [673.685843] [120/133] (360s left) gem_exec_reloc (basic-gtt-active) [673.743871] Subtest basic-gtt-active: SKIP (0.000s) [673.813533] [121/133] (360s left) gem_mmap_gtt (fault-concurrent-y) [673.858648] Subtest fault-concurrent-Y: SKIP (0.000s) [673.928019] [122/133] (360s left) kms_plane_alpha_blend (alpha-opaque-fb) [674.032030] Starting subtest: alpha-opaque-fb [674.324909] Starting dynamic subtest: pipe-A-eDP-1 [674.959812] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s) [674.970793] Starting dynamic subtest: pipe-D-eDP-1 [676.350104] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.350s) [676.352606] Subtest alpha-opaque-fb: SUCCESS (2.246s) [677.214470] [123/133] (357s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [677.270641] Starting subtest: single-wait-all-for-submit-available-signaled [677.272889] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [677.380723] [124/133] (357s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [677.477502] Starting subtest: plane-upscale-20x20-with-pixel-format [677.479826] Starting dynamic subtest: pipe-A [678.562227] Dynamic subtest pipe-A: SUCCESS (1.062s) [678.575422] Starting dynamic subtest: pipe-B [680.697202] Dynamic subtest pipe-B: SUCCESS (2.095s) [680.714222] Starting dynamic subtest: pipe-C [681.892840] Dynamic subtest pipe-C: SUCCESS (1.177s) [681.903636] Starting dynamic subtest: pipe-D [683.049614] Dynamic subtest pipe-D: SUCCESS (1.141s) [683.051876] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.481s) [684.255361] [125/133] (350s left) kms_psr (fbc-psr-cursor-mmap-cpu) [684.344807] Starting subtest: fbc-psr-cursor-mmap-cpu [684.346643] Starting dynamic subtest: eDP-1 [684.350678] Dynamic subtest eDP-1: SKIP (0.000s) [684.354783] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.001s) [684.423101] [126/133] (350s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [684.527768] Starting subtest: pr-overlay-plane-move-continuous-sf [684.531860] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [684.607784] [127/133] (350s left) kms_cdclk (plane-scaling) [684.703807] Starting subtest: plane-scaling [684.706064] Starting dynamic subtest: pipe-A-eDP-1 [684.994833] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s) [685.005587] Starting dynamic subtest: pipe-B-eDP-1 [685.009911] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [685.019994] Starting dynamic subtest: pipe-C-eDP-1 [685.024457] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [685.034682] Starting dynamic subtest: pipe-D-eDP-1 [685.038922] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [685.043169] Subtest plane-scaling: SKIP (0.296s) [685.796447] [128/133] (348s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [685.896204] Starting subtest: fbc-dirtyfb-ioctl [685.898402] Starting dynamic subtest: A-eDP-1 [688.467014] Dynamic subtest A-eDP-1: SUCCESS (2.553s) [688.469366] Subtest fbc-dirtyfb-ioctl: SUCCESS (2.554s) [689.280270] [129/133] (345s left) i915_hangman (engine-engine-error) [689.363607] Starting subtest: engine-engine-error [689.365952] Starting dynamic subtest: rcs0 [690.625611] Dynamic subtest rcs0: SUCCESS (1.255s) [690.642092] Starting dynamic subtest: bcs0 [692.608417] Dynamic subtest bcs0: SUCCESS (1.972s) [692.621615] Starting dynamic subtest: vcs0 [694.655526] Dynamic subtest vcs0: SUCCESS (2.037s) [694.669377] Starting dynamic subtest: vcs1 [696.640969] Dynamic subtest vcs1: SUCCESS (1.977s) [696.654729] Starting dynamic subtest: vecs0 [698.624064] Dynamic subtest vecs0: SUCCESS (1.976s) [698.640489] Starting dynamic subtest: ccs0 [700.608577] Dynamic subtest ccs0: SUCCESS (1.978s) [700.611327] Subtest engine-engine-error: SUCCESS (11.213s) [700.729659] [130/133] (334s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc) [700.827606] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc [700.829895] Starting dynamic subtest: pipe-A-eDP-1 [700.852299] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [700.864967] Starting dynamic subtest: pipe-B-eDP-1 [700.885451] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [700.895313] Starting dynamic subtest: pipe-C-eDP-1 [700.916145] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [700.925675] Starting dynamic subtest: pipe-D-eDP-1 [700.949455] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [700.954499] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [703.087960] [131/133] (331s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [703.183110] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [703.185221] Starting dynamic subtest: pipe-A-eDP-1 [703.206554] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [703.219956] Starting dynamic subtest: pipe-B-eDP-1 [703.241136] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [703.253280] Starting dynamic subtest: pipe-C-eDP-1 [703.274311] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [703.284210] Starting dynamic subtest: pipe-D-eDP-1 [703.305457] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [703.309343] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s) [705.492604] [132/133] (329s left) kms_frontbuffer_tracking (fbcpsr-indfb-scaledprimary) [705.591711] Starting subtest: fbcpsr-indfb-scaledprimary [711.368716] Subtest fbcpsr-indfb-scaledprimary: SUCCESS (5.776s) [711.495397] [133/133] (323s left) kms_feature_discovery (chamelium) [711.585468] Starting subtest: chamelium [711.589733] Subtest chamelium: SKIP (0.000s) [711.659386] Closing watchdogs results: parsing output: 0/ for test: gem_render_copy results: parsing output: 1/ for test: gem_wait results: parsing output: 2/ for test: gem_readwrite results: parsing output: 3/ for test: kms_big_fb results: parsing output: 4/ for test: kms_plane results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: kms_frontbuffer_tracking results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_wait results: parsing output: 9/ for test: kms_flip results: parsing output: 10/ for test: perf_pmu results: parsing output: 11/ for test: gem_exec_fence results: parsing output: 12/ for test: kms_atomic_interruptible results: parsing output: 13/ for test: syncobj_wait results: parsing output: 14/ for test: kms_content_protection results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: core_auth results: parsing output: 17/ for test: gem_exec_schedule results: parsing output: 18/ for test: kms_big_fb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: kms_big_fb results: parsing output: 22/ for test: gem_exec_schedule results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: syncobj_timeline results: parsing output: 25/ for test: kms_prop_blob results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: sw_sync results: parsing output: 28/ for test: api_intel_allocator results: parsing output: 29/ for test: i915_query results: parsing output: 30/ for test: kms_cursor_crc results: parsing output: 31/ for test: kms_big_fb results: parsing output: 32/ for test: sw_sync results: parsing output: 33/ for test: perf_pmu results: parsing output: 34/ for test: kms_psr results: parsing output: 35/ for test: core_getstats results: parsing output: 36/ for test: gem_mmap_gtt results: parsing output: 37/ for test: kms_frontbuffer_tracking results: parsing output: 38/ for test: prime_vgem results: parsing output: 39/ for test: syncobj_wait results: parsing output: 40/ for test: kms_frontbuffer_tracking results: parsing output: 41/ for test: gem_ctx_persistence results: parsing output: 42/ for test: gem_ppgtt results: parsing output: 43/ for test: gem_ctx_param results: parsing output: 44/ for test: i915_pm_rpm results: parsing output: 45/ for test: gem_exec_fence results: parsing output: 46/ for test: gem_softpin results: parsing output: 47/ for test: gem_basic results: parsing output: 48/ for test: kms_vblank results: parsing output: 49/ for test: kms_psr results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: kms_flip results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: kms_chamelium_color results: parsing output: 54/ for test: i915_drm_fdinfo results: parsing output: 55/ for test: dmabuf_sync_file results: parsing output: 56/ for test: syncobj_timeline results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: kms_cursor_legacy results: parsing output: 59/ for test: kms_big_fb results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: kms_plane_cursor results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: gem_workarounds results: parsing output: 64/ for test: gen3_render_linear_blits results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: kms_frontbuffer_tracking results: parsing output: 67/ for test: kms_flip_scaled_crc results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: syncobj_basic results: parsing output: 70/ for test: kms_frontbuffer_tracking results: parsing output: 71/ for test: kms_cursor_crc results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: kms_chamelium_frames results: parsing output: 75/ for test: kms_flip results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: gem_create results: parsing output: 78/ for test: kms_psr results: parsing output: 79/ for test: gen7_exec_parse results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: gem_ppgtt results: parsing output: 82/ for test: kms_cursor_edge_walk results: parsing output: 83/ for test: gem_exec_alignment results: parsing output: 84/ for test: kms_flip_scaled_crc results: parsing output: 85/ for test: kms_ccs results: parsing output: 86/ for test: kms_psr results: parsing output: 87/ for test: kms_psr results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: fbdev results: parsing output: 90/ for test: gem_pwrite_snooped results: parsing output: 91/ for test: kms_color results: parsing output: 92/ for test: gem_exec_schedule results: parsing output: 93/ for test: gem_render_copy results: parsing output: 94/ for test: gem_exec_balancer results: parsing output: 95/ for test: kms_big_fb results: parsing output: 96/ for test: sysfs_heartbeat_interval results: parsing output: 97/ for test: kms_getfb results: parsing output: 98/ for test: kms_invalid_mode results: parsing output: 99/ for test: kms_atomic results: parsing output: 100/ for test: kms_lease results: parsing output: 101/ for test: gem_exercise_blt results: parsing output: 102/ for test: kms_flip results: parsing output: 103/ for test: kms_ccs results: parsing output: 104/ for test: gem_exec_reloc results: parsing output: 105/ for test: kms_addfb_basic results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_getfb results: parsing output: 109/ for test: kms_vblank results: parsing output: 110/ for test: gem_lmem_swapping results: parsing output: 111/ for test: syncobj_wait results: parsing output: 112/ for test: kms_pm_rpm results: parsing output: 113/ for test: prime_busy results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_pm_backlight results: parsing output: 116/ for test: kms_cursor_legacy results: parsing output: 117/ for test: kms_rotation_crc results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_exec_reloc results: parsing output: 120/ for test: gem_mmap_gtt results: parsing output: 121/ for test: kms_plane_alpha_blend results: parsing output: 122/ for test: syncobj_timeline results: parsing output: 123/ for test: kms_plane_scaling results: parsing output: 124/ for test: kms_psr results: parsing output: 125/ for test: kms_psr2_sf results: parsing output: 126/ for test: kms_cdclk results: parsing output: 127/ for test: kms_dirtyfb results: parsing output: 128/ for test: i915_hangman results: parsing output: 129/ for test: kms_ccs results: parsing output: 130/ for test: kms_ccs results: parsing output: 131/ for test: kms_frontbuffer_tracking results: parsing output: 132/ for test: kms_feature_discovery Done.