[22.208651] Initializing watchdogs [22.208696] /dev/watchdog0 [22.212917] [001/130] (960s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-sf) [22.349897] Subtest psr2-overlay-plane-move-continuous-exceed-sf: SKIP (0.000s) [22.366072] [002/130] (960s left) kms_pipe_crc_basic (read-crc-frame-sequence) [22.441876] Starting subtest: read-crc-frame-sequence [22.442653] Starting dynamic subtest: pipe-A-HDMI-A-1 [22.759538] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.317s) [22.762960] Starting dynamic subtest: pipe-B-HDMI-A-1 [23.039262] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.279s) [23.043622] Starting dynamic subtest: pipe-C-HDMI-A-1 [23.317869] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.277s) [23.321234] Starting dynamic subtest: pipe-D-HDMI-A-1 [23.599783] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.280s) [23.600615] Subtest read-crc-frame-sequence: SUCCESS (1.158s) [23.681513] [003/130] (959s left) perf_pmu (multi-client) [23.715388] Starting subtest: multi-client [23.716233] Starting dynamic subtest: rcs0 [24.768122] Dynamic subtest rcs0: SUCCESS (1.044s) [24.774715] Starting dynamic subtest: bcs0 [25.799112] Dynamic subtest bcs0: SUCCESS (1.031s) [25.805738] Starting dynamic subtest: vcs0 [26.826918] Dynamic subtest vcs0: SUCCESS (1.028s) [26.833482] Starting dynamic subtest: vcs1 [27.860108] Dynamic subtest vcs1: SUCCESS (1.033s) [27.867132] Starting dynamic subtest: vecs0 [28.878650] Dynamic subtest vecs0: SUCCESS (1.019s) [28.879859] Subtest multi-client: SUCCESS (5.155s) [28.925839] [004/130] (953s left) kms_addfb_basic (unused-handle) [28.953614] Starting subtest: unused-handle [28.954383] Subtest unused-handle: SUCCESS (0.000s) [29.074674] [005/130] (953s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0) [29.170329] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0 [29.702864] Subtest y-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (0.532s) [29.811786] [006/130] (952s left) gem_exec_fence (basic-wait-all) [29.855040] Starting subtest: basic-wait-all [29.901489] Subtest basic-wait-all: SUCCESS (0.046s) [30.457715] [007/130] (952s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-render) [30.556820] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-render [30.558316] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [30.609031] [008/130] (952s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [30.695840] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [30.697313] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [30.751939] [009/130] (952s left) kms_psr (psr-sprite-plane-onoff) [30.843797] Subtest psr-sprite-plane-onoff: SKIP (0.000s) [30.858280] [010/130] (951s left) gem_userptr_blits (sync-unmap-cycles) [30.888084] Starting subtest: sync-unmap-cycles [36.277104] Subtest sync-unmap-cycles: SUCCESS (5.379s) [36.356393] [011/130] (946s left) syncobj_timeline (multi-wait-for-submit-available-submitted) [36.389407] Starting subtest: multi-wait-for-submit-available-submitted [36.390179] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s) [36.429486] [012/130] (946s left) gem_create (create-ext-placement-all) [36.576456] Starting subtest: create-ext-placement-all [36.577532] Subtest create-ext-placement-all: SUCCESS (0.000s) [36.631300] [013/130] (946s left) gem_mmap_wc (read) [36.667913] Starting subtest: read [36.675117] Subtest read: SUCCESS (0.007s) [36.736111] [014/130] (946s left) kms_cursor_crc (cursor-random-32x32) [36.820359] Starting subtest: cursor-random-32x32 [36.864789] Subtest cursor-random-32x32: SKIP (0.043s) [36.937268] [015/130] (945s left) gem_mmap_offset (mmap-unmap) [36.974853] Starting subtest: mmap-unmap [36.975637] Starting dynamic subtest: smem0 [56.628529] Dynamic subtest smem0: SUCCESS (19.529s) [56.629667] Subtest mmap-unmap: SUCCESS (19.529s) [56.659701] [016/130] (926s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [56.757844] Starting subtest: yf-tiled-16bpp-rotate-0 [56.759244] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [56.803898] [017/130] (926s left) api_intel_bb (add-remove-objects) [56.841858] Starting subtest: add-remove-objects [56.846088] Subtest add-remove-objects: SUCCESS (0.004s) [56.935175] [018/130] (926s left) kms_plane_cursor (viewport) [57.026808] Starting subtest: viewport [57.028411] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64 [58.468585] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.438s) [58.508843] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128 [59.954693] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.450s) [59.999500] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256 [61.440298] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.450s) [61.527711] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64 [62.962476] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.436s) [62.992278] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128 [64.430658] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.442s) [64.462211] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256 [65.857158] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.400s) [65.926501] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64 [67.422424] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.498s) [67.453284] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128 [68.889833] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.442s) [68.918654] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256 [70.366135] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.450s) [70.443495] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64 [71.880784] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.440s) [71.912262] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128 [73.372864] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.467s) [73.401865] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256 [74.806670] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.409s) [74.881990] Subtest viewport: SUCCESS (17.840s) [74.956769] [019/130] (908s left) gem_exec_balancer (nohangcheck) [75.184885] Starting subtest: nohangcheck [75.853720] Subtest nohangcheck: SUCCESS (0.667s) [75.880687] [020/130] (907s left) gem_caching (read-writes) [75.907946] Starting subtest: read-writes [86.661306] Subtest read-writes: SUCCESS (10.752s) [86.755290] [021/130] (896s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [86.848387] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [86.849781] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [86.916155] [022/130] (896s left) drm_fdinfo (busy) [86.954469] Starting subtest: busy [86.955183] Starting dynamic subtest: rcs0 [87.486132] Dynamic subtest rcs0: SUCCESS (0.519s) [87.497053] Starting dynamic subtest: bcs0 [87.991620] Dynamic subtest bcs0: SUCCESS (0.516s) [87.999348] Starting dynamic subtest: vcs0 [88.514576] Dynamic subtest vcs0: SUCCESS (0.522s) [88.522350] Starting dynamic subtest: vcs1 [89.037775] Dynamic subtest vcs1: SUCCESS (0.522s) [89.045451] Starting dynamic subtest: vecs0 [89.565665] Dynamic subtest vecs0: SUCCESS (0.527s) [89.566983] Subtest busy: SUCCESS (2.611s) [89.606690] [023/130] (893s left) gem_mmap (bad-offset) [89.636458] Starting subtest: bad-offset [89.637245] Subtest bad-offset: SUCCESS (0.000s) [89.700607] [024/130] (893s left) kms_psr (fbc-psr-suspend) [89.789797] Subtest fbc-psr-suspend: SKIP (0.000s) [89.803738] [025/130] (893s left) kms_psr (fbc-psr2-sprite-mmap-gtt) [89.883991] Subtest fbc-psr2-sprite-mmap-gtt: SKIP (0.000s) [89.904356] [026/130] (893s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [89.982733] Starting subtest: primary-y-tiled-reflect-x-270 [94.884301] Subtest primary-y-tiled-reflect-x-270: SUCCESS (4.901s) [95.056230] [027/130] (888s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs) [95.151795] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs [95.153267] Starting dynamic subtest: pipe-A-HDMI-A-1 [95.826236] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.670s) [95.833455] Starting dynamic subtest: pipe-B-HDMI-A-1 [96.526871] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.699s) [96.533832] Starting dynamic subtest: pipe-C-HDMI-A-1 [97.220867] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.692s) [97.228470] Starting dynamic subtest: pipe-D-HDMI-A-1 [97.920066] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.696s) [97.921272] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs: SUCCESS (2.764s) [98.082895] [028/130] (885s left) kms_writeback (writeback-fb-id) [98.171865] Subtest writeback-fb-id: SKIP (0.000s) [98.188359] [029/130] (884s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [98.268497] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc [98.269890] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [98.323310] [030/130] (884s left) gem_ctx_create (basic) [98.363895] Starting subtest: basic [98.364684] Subtest basic: SUCCESS (0.000s) [98.521391] [031/130] (884s left) gem_ctx_persistence (legacy-engines-mixed-process) [98.560886] Starting subtest: legacy-engines-mixed-process [98.561704] Starting dynamic subtest: render [98.876793] Dynamic subtest render: SUCCESS (0.315s) [98.881942] Starting dynamic subtest: bsd1 [99.216463] Dynamic subtest bsd1: SUCCESS (0.339s) [99.224193] Starting dynamic subtest: bsd2 [99.548457] Dynamic subtest bsd2: SUCCESS (0.331s) [99.560729] Starting dynamic subtest: blt [99.905916] Dynamic subtest blt: SUCCESS (0.356s) [99.919191] Starting dynamic subtest: vebox [100.247674] Dynamic subtest vebox: SUCCESS (0.341s) [100.248961] Subtest legacy-engines-mixed-process: SUCCESS (1.686s) [100.294159] [032/130] (882s left) gem_exec_schedule (semaphore-codependency) [100.338663] Starting subtest: semaphore-codependency [100.344543] Subtest semaphore-codependency: SUCCESS (0.005s) [100.613798] [033/130] (882s left) kms_chamelium_audio (dp-audio) [100.756950] Subtest dp-audio: SKIP (0.000s) [100.810910] [034/130] (882s left) kms_addfb_basic (bad-pitch-65536) [100.834832] Starting subtest: bad-pitch-65536 [100.835620] Subtest bad-pitch-65536: SUCCESS (0.000s) [100.965751] [035/130] (882s left) gem_exec_balancer (bonded-pair) [101.004282] Starting subtest: bonded-pair [132.691260] Subtest bonded-pair: SUCCESS (31.677s) [132.904680] [036/130] (850s left) syncobj_wait (invalid-reset-illegal-handle) [132.932645] Starting subtest: invalid-reset-illegal-handle [132.933421] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [132.972109] [037/130] (850s left) kms_pm_backlight (fade-with-suspend) [133.058025] Subtest fade-with-suspend: SKIP (0.000s) [133.074633] [038/130] (850s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs) [133.153018] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs [133.153779] Starting dynamic subtest: pipe-A-HDMI-A-1 [133.811730] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.655s) [133.819147] Starting dynamic subtest: pipe-B-HDMI-A-1 [134.513547] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.700s) [134.519580] Starting dynamic subtest: pipe-C-HDMI-A-1 [135.197586] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.681s) [135.205423] Starting dynamic subtest: pipe-D-HDMI-A-1 [135.880237] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.681s) [135.881341] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs: SUCCESS (2.724s) [136.018864] [039/130] (847s left) prime_vgem (basic-gtt) [136.063661] Starting subtest: basic-gtt [136.073488] Subtest basic-gtt: SUCCESS (0.010s) [136.157535] [040/130] (847s left) kms_flip (flip-vs-expired-vblank) [136.249606] Starting subtest: flip-vs-expired-vblank [136.251314] Starting dynamic subtest: A-HDMI-A1 [143.928384] Dynamic subtest A-HDMI-A1: SUCCESS (7.658s) [143.934403] Starting dynamic subtest: B-HDMI-A1 [151.563275] Dynamic subtest B-HDMI-A1: SUCCESS (7.651s) [151.568444] Starting dynamic subtest: C-HDMI-A1 [159.201821] Dynamic subtest C-HDMI-A1: SUCCESS (7.638s) [159.207267] Starting dynamic subtest: D-HDMI-A1 [166.873366] Dynamic subtest D-HDMI-A1: SUCCESS (7.645s) [166.874439] Subtest flip-vs-expired-vblank: SUCCESS (30.599s) [166.991602] [041/130] (816s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [167.089315] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [167.090752] Subtest psr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [167.145714] [042/130] (816s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0) [167.243673] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0 [167.862467] Subtest x-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.618s) [167.974790] [043/130] (815s left) kms_big_fb (linear-16bpp-rotate-180) [168.066842] Starting subtest: linear-16bpp-rotate-180 [169.329397] Subtest linear-16bpp-rotate-180: SUCCESS (1.262s) [169.399554] [044/130] (813s left) kms_prop_blob (invalid-set-prop) [169.430531] Starting subtest: invalid-set-prop [169.431404] Subtest invalid-set-prop: SUCCESS (0.000s) [169.466517] [045/130] (813s left) syncobj_timeline (wait-for-submit-complex) [169.495593] Starting subtest: wait-for-submit-complex [169.556895] Subtest wait-for-submit-complex: SUCCESS (0.062s) [169.600230] [046/130] (813s left) gem_userptr_blits (readonly-unsync) [169.640539] Subtest readonly-unsync: SKIP (0.000s) [169.736232] [047/130] (813s left) gem_eio (in-flight-10ms) [169.779670] Starting subtest: in-flight-10ms [172.081244] Subtest in-flight-10ms: SUCCESS (2.301s) [172.174322] [048/130] (811s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [172.304898] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [172.358272] [049/130] (811s left) kms_frontbuffer_tracking (fbc-rgb565-draw-mmap-wc) [172.439629] Starting subtest: fbc-rgb565-draw-mmap-wc [173.550660] Subtest fbc-rgb565-draw-mmap-wc: SUCCESS (1.111s) [173.656111] [050/130] (809s left) kms_lease (implicit-plane-lease) [173.744053] Starting subtest: implicit-plane-lease [173.744870] Subtest implicit-plane-lease: SUCCESS (0.001s) [173.777982] [051/130] (809s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers) [173.855314] Starting subtest: plane-upscale-20x20-with-modifiers [173.856370] Starting dynamic subtest: pipe-A [174.250180] Dynamic subtest pipe-A: SUCCESS (0.395s) [174.263425] Starting dynamic subtest: pipe-B [174.684218] Dynamic subtest pipe-B: SUCCESS (0.434s) [174.693398] Starting dynamic subtest: pipe-C [175.108610] Dynamic subtest pipe-C: SUCCESS (0.424s) [175.117490] Starting dynamic subtest: pipe-D [175.541125] Dynamic subtest pipe-D: SUCCESS (0.432s) [175.542179] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (1.687s) [175.688403] [052/130] (807s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-indfb-plflip-blt) [175.774470] Starting subtest: fbcpsr-1p-primscrn-indfb-plflip-blt [175.775948] Subtest fbcpsr-1p-primscrn-indfb-plflip-blt: SKIP (0.000s) [175.835483] [053/130] (807s left) kms_draw_crc (draw-method-mmap-wc) [175.921360] Starting subtest: draw-method-mmap-wc [175.922138] Starting dynamic subtest: xrgb8888-untiled [176.074365] Dynamic subtest xrgb8888-untiled: SUCCESS (0.152s) [176.085716] Starting dynamic subtest: rgb565-untiled [176.241148] Dynamic subtest rgb565-untiled: SUCCESS (0.165s) [176.252253] Starting dynamic subtest: xrgb2101010-untiled [176.374148] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.132s) [176.382476] Starting dynamic subtest: xrgb8888-xtiled [176.457807] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.082s) [176.468604] Starting dynamic subtest: rgb565-xtiled [176.541125] Dynamic subtest rgb565-xtiled: SUCCESS (0.082s) [176.552173] Starting dynamic subtest: xrgb2101010-xtiled [176.615943] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.074s) [176.626464] Starting dynamic subtest: xrgb8888-ytiled [176.699567] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.082s) [176.710311] Starting dynamic subtest: rgb565-ytiled [176.782989] Dynamic subtest rgb565-ytiled: SUCCESS (0.082s) [176.795728] Starting dynamic subtest: xrgb2101010-ytiled [176.857619] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.074s) [176.858920] Subtest draw-method-mmap-wc: SUCCESS (0.936s) [176.921404] [054/130] (806s left) prime_mmap (test_aperture_limit) [176.950233] Starting subtest: test_aperture_limit [176.951039] Starting dynamic subtest: test_aperture_limit-smem [176.955508] Dynamic subtest test_aperture_limit-smem: SUCCESS (0.006s) [176.956241] Subtest test_aperture_limit: SUCCESS (0.007s) [177.012021] [055/130] (806s left) gem_wait (busy) [177.050627] Starting subtest: busy [177.051472] Starting dynamic subtest: all-engines [177.569320] Dynamic subtest all-engines: SUCCESS (0.514s) [177.579739] Starting dynamic subtest: rcs0 [178.077265] Dynamic subtest rcs0: SUCCESS (0.508s) [178.081781] Starting dynamic subtest: bcs0 [178.588035] Dynamic subtest bcs0: SUCCESS (0.514s) [178.592960] Starting dynamic subtest: vcs0 [179.101126] Dynamic subtest vcs0: SUCCESS (0.513s) [179.105955] Starting dynamic subtest: vcs1 [179.613166] Dynamic subtest vcs1: SUCCESS (0.508s) [179.617711] Starting dynamic subtest: vecs0 [180.120958] Dynamic subtest vecs0: SUCCESS (0.511s) [180.121769] Subtest busy: SUCCESS (3.071s) [180.289147] [056/130] (803s left) kms_psr (fbc-pr-cursor-plane-move) [180.383942] Subtest fbc-pr-cursor-plane-move: SKIP (0.000s) [180.400085] [057/130] (803s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [180.484108] Starting subtest: sprite-rotation-90-pos-100-0 [184.126191] Subtest sprite-rotation-90-pos-100-0: SUCCESS (3.642s) [184.291992] [058/130] (799s left) gem_exec_fence (syncobj-timeline-unused-fence) [184.715278] Starting subtest: syncobj-timeline-unused-fence [184.716422] Subtest syncobj-timeline-unused-fence: SUCCESS (0.004s) [184.863912] [059/130] (798s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [184.962955] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [186.182151] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (1.219s) [186.295053] [060/130] (797s left) kms_busy (extended-modeset-hang-oldfb-with-reset) [186.394948] Starting subtest: extended-modeset-hang-oldfb-with-reset [186.396861] Starting dynamic subtest: pipe-A [187.917906] Dynamic subtest pipe-A: SUCCESS (1.521s) [187.924781] Starting dynamic subtest: pipe-D [189.461180] Dynamic subtest pipe-D: SUCCESS (1.541s) [189.461989] Subtest extended-modeset-hang-oldfb-with-reset: SUCCESS (3.067s) [189.598271] [061/130] (794s left) syncobj_timeline (device-signal-unordered) [189.632248] Starting subtest: device-signal-unordered [189.633037] Subtest device-signal-unordered: SUCCESS (0.001s) [189.673473] [062/130] (793s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [189.764590] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [189.766361] Starting dynamic subtest: pipe-A-HDMI-A-1 [189.773802] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s) [189.778323] Starting dynamic subtest: pipe-B-HDMI-A-1 [189.784727] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s) [189.788988] Starting dynamic subtest: pipe-C-HDMI-A-1 [189.796264] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s) [189.800626] Starting dynamic subtest: pipe-D-HDMI-A-1 [189.808519] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s) [189.810243] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SKIP (0.008s) [189.820534] [063/130] (793s left) api_intel_bb (render) [189.845749] Starting subtest: render [189.846422] Starting dynamic subtest: render-none-512 [189.931634] Dynamic subtest render-none-512: SUCCESS (0.086s) [189.936357] Starting dynamic subtest: render-none-1024 [190.273219] Dynamic subtest render-none-1024: SUCCESS (0.332s) [190.278225] Starting dynamic subtest: render-x-512 [190.342111] Dynamic subtest render-x-512: SUCCESS (0.077s) [190.346892] Starting dynamic subtest: render-x-1024 [190.657717] Dynamic subtest render-x-1024: SUCCESS (0.307s) [190.662551] Starting dynamic subtest: render-y-512 [190.726466] Dynamic subtest render-y-512: SUCCESS (0.077s) [190.731264] Starting dynamic subtest: render-y-1024 [191.042771] Dynamic subtest render-y-1024: SUCCESS (0.307s) [191.043628] Subtest render: SUCCESS (1.189s) [191.102310] [064/130] (792s left) gem_exec_params (secure-non-master) [191.133395] Starting subtest: secure-non-master [191.134795] Subtest secure-non-master: SKIP (0.000s) [191.194885] [065/130] (792s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-move) [191.294296] Starting subtest: psr-2p-scndscrn-spr-indfb-move [191.296012] Subtest psr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [191.364048] [066/130] (792s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-upscaling) [191.454159] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-upscaling [191.455051] Starting dynamic subtest: pipe-A-valid-mode [192.345649] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.891s) [192.346424] Subtest flip-32bpp-xtile-to-64bpp-xtile-upscaling: SUCCESS (0.892s) [192.426189] [067/130] (791s left) gem_exec_schedule (u-lateslice) [192.464542] Starting subtest: u-lateslice [192.465247] Starting dynamic subtest: rcs0 [192.478019] Dynamic subtest rcs0: SUCCESS (0.014s) [192.482959] Starting dynamic subtest: bcs0 [192.492852] Dynamic subtest bcs0: SUCCESS (0.014s) [192.497893] Starting dynamic subtest: vcs0 [192.505830] Dynamic subtest vcs0: SUCCESS (0.013s) [192.510680] Starting dynamic subtest: vcs1 [192.519026] Dynamic subtest vcs1: SUCCESS (0.013s) [192.524101] Starting dynamic subtest: vecs0 [192.531818] Dynamic subtest vecs0: SUCCESS (0.012s) [192.532549] Subtest u-lateslice: SUCCESS (0.068s) [192.810080] [068/130] (790s left) kms_flip (2x-blocking-wf_vblank) [192.896702] Starting subtest: 2x-blocking-wf_vblank [192.907435] Subtest 2x-blocking-wf_vblank: SKIP (0.011s) [192.948443] [069/130] (790s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [192.985580] Starting subtest: y-tiled-ccs-to-yf-tiled [192.986305] Starting dynamic subtest: smem [193.059860] Dynamic subtest smem: SUCCESS (0.075s) [193.060693] Subtest y-tiled-ccs-to-yf-tiled: SUCCESS (0.075s) [193.217771] [070/130] (790s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw) [193.311322] Starting subtest: fbc-1p-pri-indfb-multidraw [201.621279] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (8.309s) [201.724905] [071/130] (782s left) i915_pm_rpm (gem-execbuf) [202.916294] Starting subtest: gem-execbuf [202.917716] Starting dynamic subtest: smem0 [206.545332] Dynamic subtest smem0: SUCCESS (3.628s) [206.546554] Subtest gem-execbuf: SUCCESS (3.630s) [206.705808] [072/130] (777s left) gem_exec_parallel (contexts) [206.745625] Starting subtest: contexts [206.746382] Starting dynamic subtest: rcs0 [209.224906] Dynamic subtest rcs0: SUCCESS (2.470s) [209.233325] Starting dynamic subtest: bcs0 [211.606430] Dynamic subtest bcs0: SUCCESS (2.381s) [211.622444] Starting dynamic subtest: vcs0 [214.036420] Dynamic subtest vcs0: SUCCESS (2.429s) [214.047432] Starting dynamic subtest: vcs1 [216.461711] Dynamic subtest vcs1: SUCCESS (2.425s) [216.468751] Starting dynamic subtest: vecs0 [218.972971] Dynamic subtest vecs0: SUCCESS (2.511s) [218.973885] Subtest contexts: SUCCESS (12.219s) [219.118749] [073/130] (764s left) kms_sequence (queue-busy) [219.204052] Starting subtest: queue-busy [219.204793] Starting dynamic subtest: pipe-A-HDMI-A-1 [220.482904] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.278s) [220.488732] Starting dynamic subtest: pipe-B-HDMI-A-1 [221.731484] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.247s) [221.736350] Starting dynamic subtest: pipe-C-HDMI-A-1 [223.001283] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.269s) [223.007235] Starting dynamic subtest: pipe-D-HDMI-A-1 [224.257456] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.253s) [224.258219] Subtest queue-busy: SUCCESS (5.053s) [224.332162] [074/130] (759s left) gem_flink_basic (double-flink) [224.357548] Starting subtest: double-flink [224.358241] Subtest double-flink: SUCCESS (0.000s) [224.411613] [075/130] (759s left) prime_mmap (test_correct) [224.443848] Starting subtest: test_correct [224.444683] Starting dynamic subtest: test_correct-smem [224.445470] Dynamic subtest test_correct-smem: SUCCESS (0.002s) [224.446314] Subtest test_correct: SUCCESS (0.002s) [224.505098] [076/130] (759s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite) [224.595302] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite [225.752257] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.156s) [225.857316] [077/130] (758s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [225.956874] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [225.958205] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [226.004969] [078/130] (757s left) syncobj_wait (wait-any-interrupted) [226.036896] Starting subtest: wait-any-interrupted [226.138713] Subtest wait-any-interrupted: SUCCESS (0.101s) [226.183760] [079/130] (757s left) i915_query (query-topology-known-pci-ids) [226.209564] Starting subtest: query-topology-known-pci-ids [226.211167] Subtest query-topology-known-pci-ids: SKIP (0.000s) [226.257317] [080/130] (757s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff) [226.354180] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff [226.355545] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [226.397652] [081/130] (757s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc) [226.484454] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc [226.485921] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [226.549091] [082/130] (757s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc) [226.638599] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc [226.640161] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [226.694922] [083/130] (757s left) gem_pread (bench) [226.723915] Starting subtest: bench [227.653110] Subtest bench: SUCCESS (0.920s) [227.693475] [084/130] (756s left) syncobj_basic (test-valid-cycle) [227.728622] Starting subtest: test-valid-cycle [227.729543] Subtest test-valid-cycle: SUCCESS (0.000s) [227.768406] [085/130] (756s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format) [227.854890] Starting subtest: plane-scaler-unity-scaling-with-pixel-format [227.855640] Starting dynamic subtest: pipe-A [229.193681] Dynamic subtest pipe-A: SUCCESS (1.339s) [229.205795] Starting dynamic subtest: pipe-B [230.553472] Dynamic subtest pipe-B: SUCCESS (1.359s) [230.566021] Starting dynamic subtest: pipe-C [230.754514] Dynamic subtest pipe-C: SUCCESS (0.200s) [230.763347] Starting dynamic subtest: pipe-D [230.955065] Dynamic subtest pipe-D: SUCCESS (0.200s) [230.956554] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (3.101s) [231.096495] [086/130] (752s left) syncobj_timeline (host-signal-points) [231.129986] Starting subtest: host-signal-points [231.134573] Subtest host-signal-points: SUCCESS (0.005s) [231.176481] [087/130] (752s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-downscaling) [231.269734] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-downscaling [231.271291] Starting dynamic subtest: pipe-A-valid-mode [232.228656] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.957s) [232.229568] Subtest flip-64bpp-ytile-to-32bpp-ytile-downscaling: SUCCESS (0.959s) [232.363095] [088/130] (751s left) kms_psr (psr2-primary-render) [232.450844] Subtest psr2-primary-render: SKIP (0.000s) [232.471366] [089/130] (751s left) gem_userptr_blits (input-checking) [232.499381] Starting subtest: input-checking [232.500096] Subtest input-checking: SUCCESS (0.000s) [232.597525] [090/130] (751s left) syncobj_timeline (invalid-transfer-non-existent-point) [232.632706] Starting subtest: invalid-transfer-non-existent-point [232.633502] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [232.668750] [091/130] (751s left) kms_frontbuffer_tracking (fbcpsr-farfromfence-mmap-gtt) [232.764380] Starting subtest: fbcpsr-farfromfence-mmap-gtt [232.766084] Subtest fbcpsr-farfromfence-mmap-gtt: SKIP (0.000s) [232.841667] [092/130] (751s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-plflip-blt) [232.937787] Starting subtest: fbcpsr-2p-scndscrn-shrfb-plflip-blt [232.939179] Subtest fbcpsr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [233.001120] [093/130] (751s left) gem_pxp (hw-rejects-pxp-context) [235.560038] Starting subtest: hw-rejects-pxp-context [235.561321] Subtest hw-rejects-pxp-context: SUCCESS (0.001s) [235.602916] [094/130] (748s left) syncobj_wait (wait-for-submit-complex) [235.631848] Starting subtest: wait-for-submit-complex [235.694930] Subtest wait-for-submit-complex: SUCCESS (0.062s) [235.740998] [095/130] (748s left) drm_fdinfo (virtual-idle) [235.770692] Starting subtest: virtual-idle [238.296129] Subtest virtual-idle: SUCCESS (2.514s) [238.325373] [096/130] (745s left) gem_ccs (block-multicopy-inplace) [238.357156] Starting subtest: block-multicopy-inplace [238.358665] Subtest block-multicopy-inplace: SKIP (0.000s) [238.402684] [097/130] (745s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted) [238.439680] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted [238.546703] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [238.594844] [098/130] (745s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [239.029859] Starting subtest: syncobj-stationary-timeline-chain-engines [239.087818] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.059s) [239.249673] [099/130] (744s left) kms_big_fb (y-tiled-32bpp-rotate-270) [239.341775] Starting subtest: y-tiled-32bpp-rotate-270 [240.290887] Subtest y-tiled-32bpp-rotate-270: SUCCESS (0.949s) [240.429309] [100/130] (743s left) gem_render_copy_redux (flink-interruptible) [240.456360] Starting subtest: flink-interruptible [241.359540] Subtest flink-interruptible: SUCCESS (0.903s) [241.456469] [101/130] (742s left) sriov_basic (bind-unbind-vf) [241.494042] Subtest bind-unbind-vf: SKIP (0.000s) [241.516761] [102/130] (742s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt) [241.604618] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt [241.606162] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [241.672633] [103/130] (742s left) kms_async_flips (async-flip-suspend-resume) [241.760017] Starting subtest: async-flip-suspend-resume [241.868621] Starting dynamic subtest: pipe-A-HDMI-A-1 [258.645372] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.442s) [258.758023] Starting dynamic subtest: pipe-B-HDMI-A-1 [260.822789] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.063s) [260.916308] Starting dynamic subtest: pipe-C-HDMI-A-1 [262.978189] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.058s) [263.070451] Starting dynamic subtest: pipe-D-HDMI-A-1 [265.135671] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.062s) [265.136447] Subtest async-flip-suspend-resume: SUCCESS (9.046s) [265.294490] [104/130] (733s left) kms_addfb_basic (bo-too-small-due-to-tiling) [265.389904] Starting subtest: bo-too-small-due-to-tiling [265.390621] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [265.434284] [105/130] (733s left) gen9_exec_parse (bb-large) [265.465011] Subtest bb-large: SKIP (0.000s) [265.485214] [106/130] (733s left) kms_color (ctm-0-50) [265.568091] Starting subtest: ctm-0-50 [265.569882] Starting dynamic subtest: pipe-A-HDMI-A-1 [266.325782] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.751s) [266.332751] Starting dynamic subtest: pipe-B-HDMI-A-1 [267.050824] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.714s) [267.058062] Starting dynamic subtest: pipe-C-HDMI-A-1 [267.772082] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.711s) [267.779092] Starting dynamic subtest: pipe-D-HDMI-A-1 [268.507854] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.727s) [268.508638] Subtest ctm-0-50: SUCCESS (2.910s) [268.605721] [107/130] (730s left) kms_vblank (wait-forked-busy) [268.688874] Starting subtest: wait-forked-busy [268.691020] Starting dynamic subtest: pipe-A-HDMI-A-1 [269.961457] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.258s) [269.969629] Starting dynamic subtest: pipe-D-HDMI-A-1 [271.217852] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.243s) [271.218564] Subtest wait-forked-busy: SUCCESS (2.507s) [271.335116] [108/130] (727s left) gem_exec_params (rsvd2-dirt) [271.368604] Starting subtest: rsvd2-dirt [271.370096] Subtest rsvd2-dirt: SKIP (0.000s) [271.431125] [109/130] (727s left) kms_big_fb (4-tiled-addfb) [271.523239] Starting subtest: 4-tiled-addfb [271.524805] Subtest 4-tiled-addfb: SKIP (0.000s) [271.590580] [110/130] (727s left) kms_invalid_mode (int-max-clock) [271.680695] Starting subtest: int-max-clock [271.681425] Starting dynamic subtest: pipe-A-HDMI-A-1 [271.726396] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.045s) [271.733515] Starting dynamic subtest: pipe-B-HDMI-A-1 [271.734259] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s) [271.739658] Starting dynamic subtest: pipe-C-HDMI-A-1 [271.740423] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s) [271.746060] Starting dynamic subtest: pipe-D-HDMI-A-1 [271.746808] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s) [271.747566] Subtest int-max-clock: SUCCESS (0.051s) [271.824297] [111/130] (726s left) gem_exec_balancer (persistence) [272.051658] Starting subtest: persistence [272.718665] Subtest persistence: SUCCESS (0.662s) [272.761098] [112/130] (726s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-gtt) [272.854740] Starting subtest: fbcpsr-rgb565-draw-mmap-gtt [272.856247] Subtest fbcpsr-rgb565-draw-mmap-gtt: SKIP (0.000s) [272.924731] [113/130] (725s left) kms_cursor_crc (cursor-rapid-movement-32x10) [273.010868] Starting subtest: cursor-rapid-movement-32x10 [273.056524] Subtest cursor-rapid-movement-32x10: SKIP (0.043s) [273.105626] [114/130] (725s left) kms_psr (pr-primary-page-flip) [273.189835] Subtest pr-primary-page-flip: SKIP (0.000s) [273.208783] [115/130] (725s left) kms_chamelium_frames (dp-crc-single) [273.343024] Subtest dp-crc-single: SKIP (0.000s) [273.400878] [116/130] (725s left) gem_ctx_isolation (preservation-reset) [273.540564] Starting subtest: preservation-reset [273.541673] Starting dynamic subtest: rcs0 [273.627577] Dynamic subtest rcs0: SUCCESS (0.087s) [273.633565] Starting dynamic subtest: bcs0 [273.753194] Dynamic subtest bcs0: SUCCESS (0.124s) [273.759093] Starting dynamic subtest: vcs0 [273.866966] Dynamic subtest vcs0: SUCCESS (0.113s) [273.872771] Starting dynamic subtest: vcs1 [273.998504] Dynamic subtest vcs1: SUCCESS (0.130s) [274.004543] Starting dynamic subtest: vecs0 [274.129250] Dynamic subtest vecs0: SUCCESS (0.130s) [274.130113] Subtest preservation-reset: SUCCESS (0.588s) [274.221086] [117/130] (724s left) gem_softpin (allocator-nopin) [274.258797] Starting subtest: allocator-nopin [274.312493] Subtest allocator-nopin: SUCCESS (0.053s) [274.390241] [118/130] (724s left) gem_exec_schedule (fairslice-all) [274.431053] Starting subtest: fairslice-all [276.460820] Subtest fairslice-all: SUCCESS (2.019s) [276.733023] [119/130] (722s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt) [276.826066] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt [277.928438] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SUCCESS (1.099s) [278.019157] [120/130] (720s left) gen9_exec_parse (secure-batches) [278.050368] Subtest secure-batches: SKIP (0.000s) [278.072077] [121/130] (720s left) kms_dirtyfb (drrs-dirtyfb-ioctl) [278.189797] Starting subtest: drrs-dirtyfb-ioctl [278.191397] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s) [278.250228] [122/130] (720s left) syncobj_timeline (wait-any-interrupted) [278.280763] Starting subtest: wait-any-interrupted [278.382745] Subtest wait-any-interrupted: SUCCESS (0.102s) [278.430803] [123/130] (720s left) gem_lmem_swapping (heavy-multi) [278.462163] Subtest heavy-multi: SKIP (0.000s) [278.478843] [124/130] (720s left) kms_frontbuffer_tracking (psr-2p-primscrn-shrfb-pgflip-blt) [278.563166] Starting subtest: psr-2p-primscrn-shrfb-pgflip-blt [278.564487] Subtest psr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [278.626988] [125/130] (720s left) gem_partial_pwrite_pread (reads-uncached) [278.663010] Starting subtest: reads-uncached [280.044833] Subtest reads-uncached: SUCCESS (1.378s) [280.143852] [126/130] (718s left) perf (create-destroy-userspace-config) [280.247303] Starting subtest: create-destroy-userspace-config [280.260608] Subtest create-destroy-userspace-config: SUCCESS (0.014s) [280.279707] [127/130] (718s left) i915_pm_rps (min-max-config-loaded) [280.306144] Starting subtest: min-max-config-loaded [280.629511] Subtest min-max-config-loaded: SUCCESS (0.318s) [280.704013] [128/130] (718s left) kms_cursor_crc (cursor-offscreen-max-size) [280.802710] Starting subtest: cursor-offscreen-max-size [280.804855] Subtest cursor-offscreen-max-size: SKIP (0.000s) [280.883573] [129/130] (718s left) kms_prime (basic-crc-vgem) [281.624806] Starting subtest: basic-crc-vgem [281.625545] Starting dynamic subtest: second-to-first [282.265564] Dynamic subtest second-to-first: SUCCESS (0.640s) [282.266746] Subtest basic-crc-vgem: SUCCESS (0.641s) [282.333212] [130/130] (716s left) kms_big_fb (4-tiled-16bpp-rotate-90) [282.425852] Starting subtest: 4-tiled-16bpp-rotate-90 [282.427201] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.000s) [282.471998] Closing watchdogs Done.