[61.248580] Initializing watchdogs [61.248634] /dev/watchdog0 [61.253997] [001/130] (960s left) gem_eio (wait-10ms) [61.301697] Starting subtest: wait-10ms [61.464848] Subtest wait-10ms: SUCCESS (0.160s) [61.611530] [002/130] (960s left) gem_flink_basic (flink-lifetime) [61.652198] Starting subtest: flink-lifetime [61.652878] Subtest flink-lifetime: SUCCESS (0.001s) [61.748439] [003/130] (960s left) kms_chamelium_hpd (dp-hpd) [61.901098] Subtest dp-hpd: SKIP (0.000s) [61.951012] [004/130] (959s left) prime_mmap (test_dup) [61.996366] Starting subtest: test_dup [61.997051] Starting dynamic subtest: test_dup-smem [62.044114] Dynamic subtest test_dup-smem: SUCCESS (0.047s) [62.044813] Subtest test_dup: SUCCESS (0.047s) [62.123199] [005/130] (959s left) syncobj_wait (wait-any-interrupted) [62.170809] Starting subtest: wait-any-interrupted [62.274184] Subtest wait-any-interrupted: SUCCESS (0.101s) [62.359893] [006/130] (959s left) gem_exec_fence (syncobj-channel) [62.711198] Starting subtest: syncobj-channel [63.734058] Subtest syncobj-channel: SUCCESS (1.009s) [64.043627] [007/130] (957s left) kms_plane (plane-panning-top-left) [64.148903] Starting subtest: plane-panning-top-left [64.149671] Starting dynamic subtest: pipe-A [64.703010] Dynamic subtest pipe-A: SUCCESS (0.546s) [64.709972] Starting dynamic subtest: pipe-B [65.129836] Dynamic subtest pipe-B: SUCCESS (0.421s) [65.130587] Subtest plane-panning-top-left: SUCCESS (0.970s) [65.288730] [008/130] (956s left) gem_exec_reloc (basic-wc-read-active) [65.330045] Subtest basic-wc-read-active: SKIP (0.000s) [65.408054] [009/130] (956s left) syncobj_timeline (single-wait-for-submit-signaled) [65.472836] Starting subtest: single-wait-for-submit-signaled [65.473668] Subtest single-wait-for-submit-signaled: SUCCESS (0.001s) [65.556630] [010/130] (956s left) gem_mmap_wc (write-read-distinct) [65.594904] Starting subtest: write-read-distinct [65.597097] Subtest write-read-distinct: SUCCESS (0.002s) [65.730515] [011/130] (956s left) sysfs_heartbeat_interval (precise) [65.776025] Starting subtest: precise [65.776723] Starting dynamic subtest: vecs0 [67.462849] Dynamic subtest vecs0: SUCCESS (1.671s) [67.471545] Starting dynamic subtest: vcs0 [69.093958] Dynamic subtest vcs0: SUCCESS (1.619s) [69.102425] Starting dynamic subtest: bcs0 [70.707942] Dynamic subtest bcs0: SUCCESS (1.605s) [70.714963] Starting dynamic subtest: rcs0 [72.273047] Dynamic subtest rcs0: SUCCESS (1.558s) [72.274513] Subtest precise: SUCCESS (6.456s) [72.348662] [012/130] (949s left) kms_ccs (ccs-on-another-bo-y-tiled-ccs) [72.455902] Starting subtest: ccs-on-another-bo-y-tiled-ccs [72.456666] Starting dynamic subtest: pipe-A-HDMI-A-2 [72.463670] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [72.468153] Starting dynamic subtest: pipe-B-HDMI-A-2 [72.475124] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [72.476499] Subtest ccs-on-another-bo-y-tiled-ccs: SKIP (0.001s) [72.667463] [013/130] (949s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [72.711628] Starting subtest: invalid-multi-wait-all-unsubmitted [72.712293] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [72.782986] [014/130] (949s left) gem_softpin (evict-snoop-interruptible) [72.830045] Starting subtest: evict-snoop-interruptible [72.831357] Subtest evict-snoop-interruptible: SKIP (0.000s) [72.911539] [015/130] (949s left) i915_suspend (sysfs-reader) [72.945441] Starting subtest: sysfs-reader [91.756178] Subtest sysfs-reader: SUCCESS (18.785s) [93.789038] [016/130] (930s left) syncobj_basic (bad-pad-fd-to-handle) [93.828979] Starting subtest: bad-pad-fd-to-handle [93.829640] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [93.897060] [017/130] (930s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-cpu) [94.008178] Starting subtest: fbc-rgb565-draw-mmap-cpu [96.433329] Subtest fbc-rgb565-draw-mmap-cpu: SUCCESS (2.425s) [96.565157] [018/130] (927s left) gem_userptr_blits (map-fixed-invalidate-busy) [96.619003] Starting subtest: map-fixed-invalidate-busy [96.619697] Starting dynamic subtest: gtt [97.312829] Dynamic subtest gtt: SUCCESS (0.694s) [97.318419] Starting dynamic subtest: wb [97.963510] Dynamic subtest wb: SUCCESS (0.650s) [97.968983] Starting dynamic subtest: wc [98.684277] Dynamic subtest wc: SUCCESS (0.721s) [98.689668] Starting dynamic subtest: uc [99.456137] Dynamic subtest uc: SUCCESS (0.772s) [99.456812] Subtest map-fixed-invalidate-busy: SUCCESS (2.837s) [99.608168] [019/130] (924s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled) [99.644751] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [99.645419] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [99.732805] [020/130] (924s left) kms_atomic_transition (plane-all-modeset-transition) [99.843031] Starting subtest: plane-all-modeset-transition [99.844417] Starting dynamic subtest: pipe-A-HDMI-A-2 [112.203440] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (12.356s) [112.252786] Starting dynamic subtest: pipe-B-HDMI-A-2 [120.599614] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (8.352s) [120.619745] Subtest plane-all-modeset-transition: SUCCESS (20.772s) [120.791762] [021/130] (903s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-render) [120.899307] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-render [123.292040] Subtest fbc-1p-primscrn-spr-indfb-draw-render: SUCCESS (2.393s) [123.469026] [022/130] (900s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt) [123.581291] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt [123.582574] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [123.704886] [023/130] (900s left) gem_exec_whisper (basic-queues-forked-all) [123.752727] Starting subtest: basic-queues-forked-all [126.551735] Subtest basic-queues-forked-all: SUCCESS (2.798s) [126.734210] [024/130] (897s left) kms_vrr (flip-basic-fastset) [126.840836] Starting subtest: flip-basic-fastset [126.842862] Subtest flip-basic-fastset: SKIP (0.000s) [126.931284] [025/130] (897s left) gem_mmap_wc (read-write-distinct) [126.972458] Starting subtest: read-write-distinct [126.974488] Subtest read-write-distinct: SUCCESS (0.002s) [127.102228] [026/130] (897s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf) [127.217746] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s) [127.256933] [027/130] (897s left) drm_read (fault-buffer) [127.409793] Starting subtest: fault-buffer [127.410568] Subtest fault-buffer: SUCCESS (0.001s) [127.576808] [028/130] (896s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [127.686319] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [127.687626] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [127.801131] [029/130] (896s left) gem_ctx_create (basic-files) [127.851015] Starting subtest: basic-files [129.861733] Subtest basic-files: SUCCESS (2.010s) [130.050033] [030/130] (894s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [130.165820] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [130.502641] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.337s) [130.681312] [031/130] (893s left) kms_prop_blob (blob-prop-lifetime) [130.722341] Starting subtest: blob-prop-lifetime [130.723029] Subtest blob-prop-lifetime: SUCCESS (0.001s) [130.794247] [032/130] (893s left) kms_cursor_edge_walk (256x256-right-edge) [130.908340] Starting subtest: 256x256-right-edge [130.910162] Starting dynamic subtest: pipe-A-HDMI-A-2 [134.601874] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.692s) [134.607780] Starting dynamic subtest: pipe-B-HDMI-A-2 [138.212063] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.609s) [138.212732] Subtest 256x256-right-edge: SUCCESS (7.303s) [138.312453] [033/130] (886s left) kms_flip (2x-flip-vs-absolute-wf_vblank-interruptible) [138.424066] Starting subtest: 2x-flip-vs-absolute-wf_vblank-interruptible [138.426110] Subtest 2x-flip-vs-absolute-wf_vblank-interruptible: SKIP (0.001s) [138.540663] [034/130] (886s left) gem_exec_capture (capture-recoverable) [138.577949] Starting subtest: capture-recoverable [138.579301] Subtest capture-recoverable: SKIP (0.000s) [138.700656] [035/130] (885s left) gem_exec_balancer (parallel) [139.902464] Subtest parallel: SKIP (0.000s) [139.987489] [036/130] (884s left) kms_addfb_basic (small-bo) [140.095012] Starting subtest: small-bo [140.095748] Subtest small-bo: SUCCESS (0.000s) [140.196496] [037/130] (884s left) kms_big_fb (x-tiled-8bpp-rotate-180) [140.307921] Starting subtest: x-tiled-8bpp-rotate-180 [141.721715] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.413s) [141.835275] [038/130] (882s left) gem_sync (basic-store-all) [141.881491] Starting subtest: basic-store-all [144.186915] Subtest basic-store-all: SUCCESS (2.305s) [144.385984] [039/130] (880s left) gem_exec_schedule (submit-early-slice) [144.432864] Starting subtest: submit-early-slice [144.433533] Starting dynamic subtest: rcs0 [144.453424] Dynamic subtest rcs0: SUCCESS (0.020s) [144.459239] Starting dynamic subtest: bcs0 [144.473383] Dynamic subtest bcs0: SUCCESS (0.020s) [144.479091] Starting dynamic subtest: vcs0 [144.494342] Dynamic subtest vcs0: SUCCESS (0.021s) [144.500144] Starting dynamic subtest: vecs0 [144.512772] Dynamic subtest vecs0: SUCCESS (0.018s) [144.513422] Subtest submit-early-slice: SUCCESS (0.080s) [144.821987] [040/130] (879s left) gem_pxp (protected-encrypted-src-copy-not-readible) [264.972647] Per-test timeout exceeded. Killing the current test with SIGQUIT. [267.333994] Closing watchdogs [267.336855] Initializing watchdogs [267.336902] /dev/watchdog0 [267.343828] [041/130] (757s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [267.452337] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [267.453631] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [267.547411] [042/130] (757s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite) [267.664136] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite [267.665460] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s) [267.783305] [043/130] (757s left) kms_pm_rpm (basic-pci-d3-state) [279.531099] Subtest basic-pci-d3-state: SKIP (0.000s) [279.585904] [044/130] (745s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [279.698286] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip [279.699695] Subtest yf-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SKIP (0.000s) [279.821414] [045/130] (745s left) gem_partial_pwrite_pread (reads-snoop) [279.862343] Subtest reads-snoop: SKIP (0.000s) [279.920633] [046/130] (745s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-downscaling) [280.062119] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-downscaling [280.062809] Starting dynamic subtest: pipe-A-valid-mode [280.114197] Dynamic subtest pipe-A-valid-mode: SKIP (0.050s) [280.115515] Subtest flip-32bpp-4tile-to-64bpp-4tile-downscaling: SKIP (0.051s) [280.214462] [047/130] (744s left) kms_color (ctm-0-25) [280.319887] Starting subtest: ctm-0-25 [280.320565] Starting dynamic subtest: pipe-A-HDMI-A-2 [281.644863] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.324s) [281.653131] Starting dynamic subtest: pipe-B-HDMI-A-2 [282.841494] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.196s) [282.842165] Subtest ctm-0-25: SUCCESS (2.521s) [283.013899] [048/130] (741s left) kms_chamelium_edid (dp-edid-change-during-suspend) [283.156965] Subtest dp-edid-change-during-suspend: SKIP (0.000s) [283.206543] [049/130] (741s left) api_intel_bb (object-noreloc-keep-cache-simple) [283.242488] Starting subtest: object-noreloc-keep-cache-simple [283.244395] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.002s) [283.370433] [050/130] (741s left) kms_hdr (static-toggle-suspend) [283.481896] Starting subtest: static-toggle-suspend [283.484014] Subtest static-toggle-suspend: SKIP (0.000s) [283.572765] [051/130] (741s left) kms_invalid_mode (zero-vdisplay) [283.677649] Starting subtest: zero-vdisplay [283.678393] Starting dynamic subtest: pipe-A-HDMI-A-2 [283.713561] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.036s) [283.719509] Starting dynamic subtest: pipe-B-HDMI-A-2 [283.720164] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.000s) [283.720826] Subtest zero-vdisplay: SUCCESS (0.037s) [283.878933] [052/130] (741s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [283.991415] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [283.992719] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [284.126550] [053/130] (740s left) gem_ppgtt (flink-and-close-vma-leak) [284.162410] Starting subtest: flink-and-close-vma-leak [284.165375] Subtest flink-and-close-vma-leak: SUCCESS (0.003s) [284.316204] [054/130] (740s left) kms_psr (pr-sprite-mmap-cpu) [284.426731] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [284.472914] [055/130] (740s left) perf_pmu (frequency) [284.511482] Starting subtest: frequency [284.512167] Starting dynamic subtest: gt0 [286.714941] Dynamic subtest gt0: SUCCESS (2.200s) [286.725500] Starting dynamic subtest: idle-gt0 [287.220156] Dynamic subtest idle-gt0: SUCCESS (0.505s) [287.221556] Subtest frequency: SUCCESS (2.708s) [287.304414] [056/130] (737s left) gem_render_copy (linear-to-vebox-yf-tiled) [287.342338] Starting subtest: linear-to-vebox-yf-tiled [287.343080] Starting dynamic subtest: smem [287.410080] Dynamic subtest smem: SUCCESS (0.067s) [287.410780] Subtest linear-to-vebox-yf-tiled: SUCCESS (0.068s) [287.590918] [057/130] (737s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [287.701569] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [287.702906] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [287.828272] [058/130] (737s left) gem_ctx_persistence (heartbeat-hostile) [287.868203] Starting subtest: heartbeat-hostile [289.195337] Subtest heartbeat-hostile: SUCCESS (1.327s) [289.307920] [059/130] (735s left) gem_softpin (noreloc) [289.357470] Starting subtest: noreloc [294.782936] Subtest noreloc: SUCCESS (5.425s) [294.937521] [060/130] (730s left) gem_mmap_offset (bad-object) [294.971353] Starting subtest: bad-object [294.972085] Subtest bad-object: SUCCESS (0.001s) [295.102343] [061/130] (730s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt) [295.217821] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt [295.219222] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [295.341033] [062/130] (730s left) gem_exec_schedule (preempt-contexts) [295.389112] Starting subtest: preempt-contexts [295.389862] Starting dynamic subtest: rcs0 [295.413403] Dynamic subtest rcs0: SUCCESS (0.024s) [295.419793] Starting dynamic subtest: bcs0 [295.436805] Dynamic subtest bcs0: SUCCESS (0.023s) [295.443610] Starting dynamic subtest: vcs0 [295.460032] Dynamic subtest vcs0: SUCCESS (0.023s) [295.466847] Starting dynamic subtest: vecs0 [295.483949] Dynamic subtest vecs0: SUCCESS (0.024s) [295.484639] Subtest preempt-contexts: SUCCESS (0.095s) [295.816356] [063/130] (729s left) gem_mmap_gtt (big-bo) [295.852987] Starting subtest: big-bo [296.143292] Subtest big-bo: SUCCESS (0.291s) [296.272731] [064/130] (729s left) gem_unfence_active_buffers [296.532706] [065/130] (728s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [296.647408] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [296.648728] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [296.784869] [066/130] (728s left) gem_gpgpu_fill (basic) [296.823034] Starting subtest: basic [296.823722] Starting dynamic subtest: smem [296.825348] Dynamic subtest smem: SUCCESS (0.003s) [296.826029] Subtest basic: SUCCESS (0.003s) [296.950568] [067/130] (728s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [297.084951] Starting subtest: bad-pixel-format-4-tiled-dg2-rc-ccs-cc [297.086545] Starting dynamic subtest: pipe-A-HDMI-A-2 [297.092940] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [297.099604] Starting dynamic subtest: pipe-B-HDMI-A-2 [297.105969] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [297.107249] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.002s) [297.305362] [068/130] (728s left) kms_cursor_edge_walk (128x128-top-bottom) [297.411875] Starting subtest: 128x128-top-bottom [297.413377] Starting dynamic subtest: pipe-A-HDMI-A-2 [301.122307] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (3.709s) [301.129119] Starting dynamic subtest: pipe-B-HDMI-A-2 [304.727548] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (3.604s) [304.728210] Subtest 128x128-top-bottom: SUCCESS (7.315s) [304.828365] [069/130] (720s left) kms_draw_crc (draw-method-pwrite) [304.939533] Starting subtest: draw-method-pwrite [304.940222] Starting dynamic subtest: xrgb8888-untiled [305.409549] Dynamic subtest xrgb8888-untiled: SUCCESS (0.469s) [305.420763] Starting dynamic subtest: rgb565-untiled [305.845876] Dynamic subtest rgb565-untiled: SUCCESS (0.435s) [305.867895] Starting dynamic subtest: xrgb2101010-untiled [306.301349] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.454s) [306.322357] Starting dynamic subtest: xrgb8888-xtiled [307.022376] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.719s) [307.032553] Starting dynamic subtest: rgb565-xtiled [307.686215] Dynamic subtest rgb565-xtiled: SUCCESS (0.662s) [307.699535] Starting dynamic subtest: xrgb2101010-xtiled [308.388387] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.700s) [308.401242] Starting dynamic subtest: xrgb8888-ytiled [309.090393] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.700s) [309.103704] Starting dynamic subtest: rgb565-ytiled [309.507821] Dynamic subtest rgb565-ytiled: SUCCESS (0.416s) [309.518454] Starting dynamic subtest: xrgb2101010-ytiled [310.190976] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.681s) [310.192204] Subtest draw-method-pwrite: SUCCESS (5.252s) [310.331547] [070/130] (715s left) kms_cursor_crc (cursor-alpha-transparent) [310.439218] Starting subtest: cursor-alpha-transparent [310.441033] Starting dynamic subtest: pipe-A-HDMI-A-2 [310.903201] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.462s) [310.914772] Starting dynamic subtest: pipe-B-HDMI-A-2 [311.276767] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.371s) [311.277473] Subtest cursor-alpha-transparent: SUCCESS (0.837s) [311.445146] [071/130] (714s left) gem_softpin (full) [311.484200] Starting subtest: full [311.489377] Subtest full: SUCCESS (0.005s) [311.634697] [072/130] (713s left) kms_cursor_crc (cursor-onscreen-256x256) [311.746344] Starting subtest: cursor-onscreen-256x256 [311.748824] Starting dynamic subtest: pipe-A-HDMI-A-2 [314.236123] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.487s) [314.262695] Starting dynamic subtest: pipe-B-HDMI-A-2 [316.655655] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.398s) [316.656325] Subtest cursor-onscreen-256x256: SUCCESS (4.909s) [316.819783] [073/130] (708s left) gem_exec_schedule (in-order) [316.871621] Starting subtest: in-order [316.872310] Starting dynamic subtest: rcs0 [316.918727] Dynamic subtest rcs0: SUCCESS (0.046s) [316.930290] Starting dynamic subtest: bcs0 [316.968082] Dynamic subtest bcs0: SUCCESS (0.048s) [316.981228] Starting dynamic subtest: vcs0 [317.019356] Dynamic subtest vcs0: SUCCESS (0.050s) [317.032926] Starting dynamic subtest: vecs0 [317.070716] Dynamic subtest vecs0: SUCCESS (0.050s) [317.072081] Subtest in-order: SUCCESS (0.200s) [317.380060] [074/130] (708s left) gem_userptr_blits (coherency-unsync) [317.422807] Subtest coherency-unsync: SKIP (0.000s) [317.589399] [075/130] (708s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-pwrite) [317.697668] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-pwrite [317.698951] Subtest psr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [317.836196] [076/130] (707s left) kms_psr (fbc-psr-cursor-mmap-cpu) [317.945738] Subtest fbc-psr-cursor-mmap-cpu: SKIP (0.000s) [317.989092] [077/130] (707s left) gem_exec_params (invalid-flag) [318.028712] Starting subtest: invalid-flag [318.029390] Subtest invalid-flag: SUCCESS (0.000s) [318.157908] [078/130] (707s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt) [318.267784] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt [318.269176] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [318.365088] [079/130] (707s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [318.483945] Starting subtest: yf-tiled-16bpp-rotate-0 [318.485284] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [318.602808] [080/130] (707s left) perf (buffer-fill) [318.727777] Starting subtest: buffer-fill [318.728448] Starting dynamic subtest: 0-rcs0 [320.580569] Dynamic subtest 0-rcs0: SUCCESS (1.853s) [320.581315] Subtest buffer-fill: SUCCESS (1.853s) [320.599338] [081/130] (705s left) i915_pm_rps (thresholds-idle) [320.643677] Starting subtest: thresholds-idle [320.644472] Starting dynamic subtest: gt0 [331.370879] Dynamic subtest gt0: SUCCESS (10.726s) [331.372105] Subtest thresholds-idle: SUCCESS (10.728s) [331.448995] [082/130] (694s left) kms_psr (fbc-pr-cursor-plane-move) [331.555461] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [331.589378] [083/130] (694s left) kms_atomic (plane-overlay-legacy) [331.698117] Starting subtest: plane-overlay-legacy [331.699896] Starting dynamic subtest: pipe-A-HDMI-A-2 [331.943571] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.244s) [331.944463] Subtest plane-overlay-legacy: SUCCESS (0.246s) [332.102805] [084/130] (693s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [332.212735] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [332.214047] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [332.340903] [085/130] (693s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [332.449086] Starting subtest: plane-upscale-20x20-with-pixel-format [332.449794] Starting dynamic subtest: pipe-A [334.371796] Dynamic subtest pipe-A: SUCCESS (1.922s) [334.391202] Starting dynamic subtest: pipe-B [336.292363] Dynamic subtest pipe-B: SUCCESS (1.918s) [336.293567] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (3.844s) [336.483611] [086/130] (689s left) gem_softpin (allocator-nopin) [336.520147] Starting subtest: allocator-nopin [336.580354] Subtest allocator-nopin: SUCCESS (0.060s) [336.722526] [087/130] (689s left) perf (invalid-open-flags) [336.823398] Starting subtest: invalid-open-flags [336.824087] Subtest invalid-open-flags: SUCCESS (0.000s) [336.840140] [088/130] (689s left) drm_fdinfo (memory-info-active) [336.878315] Starting subtest: memory-info-active [336.878988] Starting dynamic subtest: smem0 [339.005885] Dynamic subtest smem0: SUCCESS (2.127s) [339.006580] Subtest memory-info-active: SUCCESS (2.128s) [339.072599] [089/130] (686s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [339.108946] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [339.210910] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.101s) [339.291971] [090/130] (686s left) gem_ctx_shared (create-shared-gtt) [339.337576] Starting subtest: create-shared-gtt [341.486958] Subtest create-shared-gtt: SUCCESS (2.149s) [341.683159] [091/130] (684s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt) [341.796496] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt [345.157084] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SUCCESS (3.361s) [345.317535] [092/130] (680s left) dumb_buffer (map-invalid-size) [345.353092] Starting subtest: map-invalid-size [345.353776] Subtest map-invalid-size: SUCCESS (0.000s) [345.479647] [093/130] (680s left) gem_userptr_blits (vma-merge) [345.530770] Starting subtest: vma-merge [345.582597] Subtest vma-merge: SUCCESS (0.052s) [345.714780] [094/130] (680s left) perf (global-sseu-config) [345.815626] Starting subtest: global-sseu-config [345.816309] Starting dynamic subtest: 0-rcs0 [345.835141] Dynamic subtest 0-rcs0: SUCCESS (0.019s) [345.835903] Subtest global-sseu-config: SUCCESS (0.020s) [345.859080] [095/130] (680s left) gem_exec_reloc (basic-write-wc-active) [345.897422] Subtest basic-write-wc-active: SKIP (0.000s) [345.975280] [096/130] (680s left) kms_flip (2x-plain-flip-fb-recreate) [346.080506] Starting subtest: 2x-plain-flip-fb-recreate [346.082930] Subtest 2x-plain-flip-fb-recreate: SKIP (0.001s) [346.210448] [097/130] (679s left) gem_ctx_shared (q-out-order) [346.255301] Starting subtest: Q-out-order [346.255995] Starting dynamic subtest: rcs0 [346.305725] Dynamic subtest rcs0: SUCCESS (0.050s) [346.316902] Starting dynamic subtest: bcs0 [346.355645] Dynamic subtest bcs0: SUCCESS (0.048s) [346.369035] Starting dynamic subtest: vcs0 [346.402956] Dynamic subtest vcs0: SUCCESS (0.045s) [346.416706] Starting dynamic subtest: vecs0 [346.450060] Dynamic subtest vecs0: SUCCESS (0.045s) [346.451347] Subtest Q-out-order: SUCCESS (0.196s) [346.656410] [098/130] (679s left) gem_reg_read (timestamp-moving) [346.694444] Starting subtest: timestamp-moving [347.695495] Subtest timestamp-moving: SUCCESS (1.000s) [347.782586] [099/130] (678s left) kms_universal_plane (universal-plane-pageflip-windowed) [347.887129] Starting subtest: universal-plane-pageflip-windowed [347.888875] Starting dynamic subtest: pipe-A-HDMI-A-2 [348.386064] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.497s) [348.394388] Starting dynamic subtest: pipe-B-HDMI-A-2 [348.759132] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.371s) [348.759818] Subtest universal-plane-pageflip-windowed: SUCCESS (0.872s) [348.872203] [100/130] (677s left) fbdev (read) [348.911279] Starting subtest: read [349.488098] Subtest read: SUCCESS (0.577s) [349.537661] [101/130] (676s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [349.643311] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs [349.645065] Starting dynamic subtest: pipe-A-HDMI-A-2 [349.651530] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.001s) [349.658294] Starting dynamic subtest: pipe-B-HDMI-A-2 [349.664659] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.001s) [349.665944] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.004s) [349.847351] [102/130] (676s left) kms_psr (psr2-suspend) [349.950490] Subtest psr2-suspend: SKIP (0.000s) [349.972741] [103/130] (676s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu) [350.085692] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu [350.086982] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [350.229828] [104/130] (676s left) gem_userptr_blits (readonly-pwrite-unsync) [350.269738] Subtest readonly-pwrite-unsync: SKIP (0.000s) [350.405982] [105/130] (675s left) kms_big_fb (y-tiled-8bpp-rotate-90) [350.517446] Starting subtest: y-tiled-8bpp-rotate-90 [350.588831] Subtest y-tiled-8bpp-rotate-90: SKIP (0.070s) [350.739146] [106/130] (675s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc) [350.846684] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc [352.849289] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (2.003s) [353.016258] [107/130] (673s left) perf_pmu (enable-race) [353.052316] Starting subtest: enable-race [353.053031] Starting dynamic subtest: rcs0 [365.636547] Dynamic subtest rcs0: SUCCESS (12.583s) [365.645994] Starting dynamic subtest: bcs0 [378.219755] Dynamic subtest bcs0: SUCCESS (12.582s) [378.227201] Starting dynamic subtest: vcs0 [390.802813] Dynamic subtest vcs0: SUCCESS (12.582s) [390.810474] Starting dynamic subtest: vecs0 [403.384783] Dynamic subtest vecs0: SUCCESS (12.581s) [403.385456] Subtest enable-race: SUCCESS (50.332s) [403.452113] [108/130] (622s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf) [403.563771] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [403.605487] [109/130] (622s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs) [403.711170] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs [403.712969] Starting dynamic subtest: pipe-A-HDMI-A-2 [403.719907] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [403.726752] Starting dynamic subtest: pipe-B-HDMI-A-2 [403.733679] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [403.735116] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.002s) [403.914010] [110/130] (622s left) kms_psr (fbc-psr2-sprite-plane-move) [404.019473] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s) [404.042066] [111/130] (622s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-pwrite) [404.151724] Starting subtest: psr-1p-primscrn-pri-indfb-draw-pwrite [404.153025] Subtest psr-1p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [404.254385] [112/130] (622s left) api_intel_bb (destroy-bb) [404.292157] Starting subtest: destroy-bb [404.297734] Subtest destroy-bb: SUCCESS (0.006s) [404.417095] [113/130] (622s left) gen9_exec_parse (basic-rejected-ctx-param) [404.453883] Subtest basic-rejected-ctx-param: SKIP (0.000s) [404.481541] [114/130] (622s left) gem_mmap_gtt (cpuset-basic-small-copy-xy) [404.519140] Starting subtest: cpuset-basic-small-copy-XY [409.831598] Subtest cpuset-basic-small-copy-XY: SUCCESS (5.307s) [409.919938] [115/130] (616s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20) [410.061119] Starting subtest: planes-downscale-factor-0-5-upscale-20x20 [410.061808] Starting dynamic subtest: pipe-A [410.202862] Dynamic subtest pipe-A: SUCCESS (0.141s) [410.222550] Starting dynamic subtest: pipe-B [410.339357] Dynamic subtest pipe-B: SUCCESS (0.134s) [410.345058] Subtest planes-downscale-factor-0-5-upscale-20x20: SUCCESS (0.279s) [410.541733] [116/130] (616s left) i915_pm_rpm (debugfs-forcewake-user) [412.001342] Starting subtest: debugfs-forcewake-user [422.386352] Subtest debugfs-forcewake-user: SUCCESS (10.385s) [422.536931] [117/130] (604s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff) [422.651682] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff [422.652974] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [422.764358] [118/130] (603s left) kms_big_fb (4-tiled-32bpp-rotate-270) [422.882147] Starting subtest: 4-tiled-32bpp-rotate-270 [422.883479] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s) [422.990895] [119/130] (603s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs-cc) [423.098182] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs-cc [423.099929] Starting dynamic subtest: pipe-A-HDMI-A-2 [423.106854] Dynamic subtest pipe-A-HDMI-A-2: SKIP (0.000s) [423.113977] Starting dynamic subtest: pipe-B-HDMI-A-2 [423.120921] Dynamic subtest pipe-B-HDMI-A-2: SKIP (0.000s) [423.122199] Subtest random-ccs-data-4-tiled-dg2-rc-ccs-cc: SKIP (0.003s) [423.303497] [120/130] (603s left) perf_pmu (semaphore-wait) [423.340476] Starting subtest: semaphore-wait [423.341162] Starting dynamic subtest: rcs0 [423.849652] Dynamic subtest rcs0: SUCCESS (0.508s) [423.862127] Starting dynamic subtest: bcs0 [424.360532] Dynamic subtest bcs0: SUCCESS (0.508s) [424.373637] Starting dynamic subtest: vcs0 [424.872377] Dynamic subtest vcs0: SUCCESS (0.509s) [424.884813] Starting dynamic subtest: vecs0 [425.383380] Dynamic subtest vecs0: SUCCESS (0.508s) [425.384540] Subtest semaphore-wait: SUCCESS (2.043s) [425.495566] [121/130] (601s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c) [425.534014] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s) [425.553280] [122/130] (601s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [425.594495] Starting subtest: multi-wait-all-for-submit-available-signaled [425.595179] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [425.671489] [123/130] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [425.782096] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [425.783466] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [425.904185] [124/130] (600s left) perf_pmu (invalid-init) [425.944242] Starting subtest: invalid-init [425.944977] Subtest invalid-init: SUCCESS (0.000s) [426.012398] [125/130] (600s left) gem_create (hog-create) [426.053099] Starting subtest: hog-create [426.053786] Starting dynamic subtest: smem0 [458.354486] Dynamic subtest smem0: SUCCESS (32.299s) [458.360293] Subtest hog-create: SUCCESS (32.301s) [458.549276] [126/130] (568s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tile-downscaling) [458.659235] Starting subtest: flip-64bpp-4tile-to-32bpp-4tile-downscaling [458.660912] Starting dynamic subtest: pipe-A-valid-mode [458.696611] Dynamic subtest pipe-A-valid-mode: SKIP (0.035s) [458.697936] Subtest flip-64bpp-4tile-to-32bpp-4tile-downscaling: SKIP (0.036s) [458.798876] [127/130] (568s left) kms_scaling_modes (scaling-mode-full) [458.908372] Starting subtest: scaling-mode-full [458.909822] Subtest scaling-mode-full: SKIP (0.000s) [458.996157] [128/130] (567s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions) [459.104535] Starting subtest: cursor-vs-flip-atomic-transitions [488.340640] Subtest cursor-vs-flip-atomic-transitions: SUCCESS (29.234s) [488.501999] [129/130] (538s left) syncobj_timeline (multi-wait-signaled) [488.539706] Starting subtest: multi-wait-signaled [488.540428] Subtest multi-wait-signaled: SUCCESS (0.000s) [488.616102] [130/130] (538s left) kms_pipe_crc_basic (hang-read-crc) [488.725399] Starting subtest: hang-read-crc [488.727110] Starting dynamic subtest: pipe-A-HDMI-A-2 [489.806540] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.079s) [489.815476] Starting dynamic subtest: pipe-B-HDMI-A-2 [490.737446] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.929s) [490.738204] Subtest hang-read-crc: SUCCESS (2.012s) [490.840127] Closing watchdogs Done.