[56.612180] Initializing watchdogs [56.612225] /dev/watchdog0 [56.625483] [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] [56.629289] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.631423] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.634728] [001/131] (960s left) gem_eio (execbuf) [56.821975] Starting subtest: execbuf [56.984106] Subtest execbuf: SUCCESS (0.163s) [57.157253] [002/131] (960s left) kms_big_fb (linear-16bpp-rotate-270) [57.266242] Starting subtest: linear-16bpp-rotate-270 [57.296209] Subtest linear-16bpp-rotate-270: SKIP (0.029s) [57.427819] [003/131] (959s left) gem_ppgtt (blt-vs-render-ctxn) [57.487246] Starting subtest: blt-vs-render-ctxN [90.500811] Subtest blt-vs-render-ctxN: SUCCESS (33.068s) [90.632571] [004/131] (926s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-wc) [90.778708] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-wc [93.812816] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-wc: SUCCESS (3.038s) [93.951901] [005/131] (923s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions) [94.079082] Starting subtest: short-busy-flip-before-cursor-atomic-transitions [94.082625] Subtest short-busy-flip-before-cursor-atomic-transitions: SKIP (0.000s) [94.183777] [006/131] (923s left) gem_userptr_blits (create-destroy-unsync) [94.248703] Subtest create-destroy-unsync: SKIP (0.000s) [94.376742] [007/131] (922s left) perf_pmu (busy-accuracy-98) [94.416776] Starting subtest: busy-accuracy-98 [94.418439] Starting dynamic subtest: rcs0 [97.462535] Dynamic subtest rcs0: SUCCESS (3.044s) [97.469979] Starting dynamic subtest: bcs0 [100.525441] Dynamic subtest bcs0: SUCCESS (3.062s) [100.534030] Starting dynamic subtest: vcs0 [103.573587] Dynamic subtest vcs0: SUCCESS (3.047s) [103.582894] Starting dynamic subtest: vcs1 [106.617663] Dynamic subtest vcs1: SUCCESS (3.044s) [106.625079] Starting dynamic subtest: vecs0 [109.662435] Dynamic subtest vecs0: SUCCESS (3.043s) [109.671709] Starting dynamic subtest: ccs0 [112.724165] Dynamic subtest ccs0: SUCCESS (3.062s) [112.726237] Subtest busy-accuracy-98: SUCCESS (18.305s) [112.830208] [008/131] (904s left) vgem_basic (busy-fence) [112.935887] Starting subtest: busy-fence [112.938173] Subtest busy-fence: SUCCESS (0.001s) [112.986881] [FACT vgem_basic (busy-fence)] new: kernel.kmod_is_loaded.vgem: true [112.989924] [009/131] (904s left) kms_scaling_modes (scaling-mode-center) [113.097859] Starting subtest: scaling-mode-center [113.100109] Starting dynamic subtest: pipe-A-eDP-1 [113.217709] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.119s) [113.227081] Starting dynamic subtest: pipe-B-eDP-1 [114.434939] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.217s) [114.442369] Starting dynamic subtest: pipe-C-eDP-1 [115.638465] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.203s) [115.646885] Starting dynamic subtest: pipe-D-eDP-1 [116.759466] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.120s) [116.761901] Subtest scaling-mode-center: SUCCESS (3.661s) [117.900716] [010/131] (899s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted) [117.959157] Starting subtest: invalid-multi-wait-all-unsubmitted [117.961779] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s) [118.054737] [011/131] (899s left) kms_flip (busy-flip) [118.156290] Starting subtest: busy-flip [118.158549] Starting dynamic subtest: A-eDP1 [119.916694] Dynamic subtest A-eDP1: SUCCESS (1.760s) [119.926663] Starting dynamic subtest: B-eDP1 [121.634931] Dynamic subtest B-eDP1: SUCCESS (1.718s) [121.646757] Starting dynamic subtest: C-eDP1 [123.352346] Dynamic subtest C-eDP1: SUCCESS (1.717s) [123.359727] Starting dynamic subtest: D-eDP1 [125.077561] Dynamic subtest D-eDP1: SUCCESS (1.725s) [125.079931] Subtest busy-flip: SUCCESS (6.925s) [126.231971] [012/131] (891s left) gem_gtt_cpu_tlb [126.341340] [013/131] (891s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu) [126.450681] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu [126.454609] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [126.549149] [014/131] (890s left) kms_psr (psr-sprite-mmap-gtt) [126.654222] Starting subtest: psr-sprite-mmap-gtt [126.656657] Starting dynamic subtest: eDP-1 [128.063809] Dynamic subtest eDP-1: SKIP (1.405s) [128.068887] Subtest psr-sprite-mmap-gtt: SKIP (1.405s) [128.191545] [015/131] (889s left) gem_mmap_gtt (basic-small-bo-tiledy) [128.251516] Subtest basic-small-bo-tiledY: SKIP (0.000s) [128.310284] [016/131] (889s left) perf (stress-open-close) [128.423443] Starting subtest: stress-open-close [128.425690] Starting dynamic subtest: 0-rcs0 [130.599340] Dynamic subtest 0-rcs0: SUCCESS (2.177s) [130.607560] Starting dynamic subtest: 1-vcs1 [132.773156] Dynamic subtest 1-vcs1: SUCCESS (2.173s) [132.775118] Subtest stress-open-close: SUCCESS (4.350s) [132.814838] [017/131] (884s left) kms_pipe_crc_basic (read-crc-frame-sequence) [132.914588] Starting subtest: read-crc-frame-sequence [132.916552] Starting dynamic subtest: pipe-A-eDP-1 [133.594659] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.679s) [133.604208] Starting dynamic subtest: pipe-B-eDP-1 [134.918103] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.321s) [134.926339] Starting dynamic subtest: pipe-C-eDP-1 [136.206793] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.290s) [136.216197] Starting dynamic subtest: pipe-D-eDP-1 [137.519956] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.312s) [137.522796] Subtest read-crc-frame-sequence: SUCCESS (4.604s) [138.362224] [018/131] (879s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [138.453932] Starting subtest: flip-32bpp-linear-to-64bpp-linear-downscaling [138.456362] Starting dynamic subtest: pipe-A-default-mode [139.620579] Dynamic subtest pipe-A-default-mode: SKIP (1.161s) [139.625085] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (1.162s) [139.777035] [019/131] (877s left) gem_busy (close-race) [139.846060] Starting subtest: close-race [163.946617] Subtest close-race: SUCCESS (24.097s) [164.338572] [020/131] (853s left) sriov_basic (enable-vfs-autoprobe-off) [164.435051] Starting subtest: enable-vfs-autoprobe-off [164.437504] Starting dynamic subtest: numvfs-1 [164.518183] Dynamic subtest numvfs-1: FAIL (0.028s) [164.526719] Starting dynamic subtest: numvfs-2 [164.599544] Dynamic subtest numvfs-2: FAIL (0.003s) [164.609069] Starting dynamic subtest: numvfs-3 [164.684526] Dynamic subtest numvfs-3: FAIL (0.003s) [164.693860] Starting dynamic subtest: numvfs-4 [164.766843] Dynamic subtest numvfs-4: FAIL (0.003s) [164.776074] Starting dynamic subtest: numvfs-5 [164.848899] Dynamic subtest numvfs-5: FAIL (0.003s) [164.858822] Starting dynamic subtest: numvfs-6 [164.932223] Dynamic subtest numvfs-6: FAIL (0.003s) [164.941168] Starting dynamic subtest: numvfs-7 [165.014896] Dynamic subtest numvfs-7: FAIL (0.003s) [165.022644] Starting dynamic subtest: numvfs-random [165.092953] Dynamic subtest numvfs-random: FAIL (0.003s) [165.101436] Starting dynamic subtest: numvfs-all [165.175339] Dynamic subtest numvfs-all: FAIL (0.508s) [165.177720] Subtest enable-vfs-autoprobe-off: FAIL (0.562s) [165.208235] [021/131] (852s left) syncobj_wait (wait-all-interrupted) [165.263271] Starting subtest: wait-all-interrupted [165.365600] Subtest wait-all-interrupted: SUCCESS (0.101s) [165.437858] [022/131] (852s left) syncobj_wait (multi-wait-all-signaled) [165.501304] Starting subtest: multi-wait-all-signaled [165.503624] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [165.607392] [023/131] (852s left) kms_psr2_sf (fbc-psr2-overlay-primary-update-sf-dmg-area) [170.630994] Starting subtest: fbc-psr2-overlay-primary-update-sf-dmg-area [170.633716] Starting dynamic subtest: pipe-A-eDP-1 [171.431448] Dynamic subtest pipe-A-eDP-1: SKIP (0.800s) [171.440020] Starting dynamic subtest: pipe-B-eDP-1 [172.659681] Dynamic subtest pipe-B-eDP-1: SKIP (1.227s) [172.664127] Subtest fbc-psr2-overlay-primary-update-sf-dmg-area: SKIP (2.030s) [173.829999] [024/131] (844s left) drm_fdinfo (virtual-busy-hang) [173.872046] Starting subtest: virtual-busy-hang [173.876134] Subtest virtual-busy-hang: SKIP (0.000s) [173.927063] [025/131] (843s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling) [174.022589] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling [174.024771] Starting dynamic subtest: pipe-A-default-mode [174.309335] Dynamic subtest pipe-A-default-mode: SKIP (0.280s) [174.314079] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.281s) [175.155650] [026/131] (842s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [175.252803] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [175.255331] Starting dynamic subtest: pipe-A-default-mode [175.541071] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [175.545837] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.283s) [176.379395] [027/131] (841s left) prime_vgem (basic-read) [176.460889] Starting subtest: basic-read [176.479866] Subtest basic-read: SKIP (0.017s) [176.582283] [028/131] (841s left) kms_chamelium_frames (dp-crc-multiple) [176.983094] Subtest dp-crc-multiple: SKIP (0.000s) [177.793383] [029/131] (840s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [177.898745] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [177.902897] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [177.990246] [030/131] (840s left) kms_psr (pr-primary-page-flip) [178.080378] Starting subtest: pr-primary-page-flip [178.084998] Subtest pr-primary-page-flip: SKIP (0.000s) [178.149203] [031/131] (839s left) gem_exec_schedule (semaphore-user) [178.220183] Starting subtest: semaphore-user [178.268594] Subtest semaphore-user: SUCCESS (0.056s) [179.982599] [032/131] (838s left) kms_plane_lowres (tiling-yf) [180.080039] Starting subtest: tiling-yf [180.084380] Subtest tiling-yf: SKIP (0.000s) [180.149613] [033/131] (838s left) gem_exec_balancer (parallel-ordering) [180.396184] Starting subtest: parallel-ordering [181.199534] Subtest parallel-ordering: SUCCESS (0.805s) [181.321903] [034/131] (836s left) gem_exec_await (wide-contexts) [181.511074] Starting subtest: wide-contexts [204.641075] Subtest wide-contexts: SUCCESS (23.129s) [204.830682] [035/131] (813s left) kms_vblank (query-busy-hang) [204.974144] Starting subtest: query-busy-hang [204.976449] Starting dynamic subtest: pipe-A-eDP-1 [232.673516] Dynamic subtest pipe-A-eDP-1: SUCCESS (27.695s) [232.688482] Starting dynamic subtest: pipe-D-eDP-1 [247.663728] Dynamic subtest pipe-D-eDP-1: SUCCESS (14.990s) [247.666250] Subtest query-busy-hang: SUCCESS (42.689s) [248.456627] [036/131] (769s left) gem_eio (in-flight-immediate) [248.650187] Starting subtest: in-flight-immediate [256.497265] Subtest in-flight-immediate: SUCCESS (7.846s) [256.612889] [037/131] (761s left) gem_mmap_offset (partial-remap) [256.677434] Starting subtest: partial-remap [256.679360] Starting dynamic subtest: smem0 [256.688446] Dynamic subtest smem0: SUCCESS (0.005s) [256.690694] Subtest partial-remap: SUCCESS (0.005s) [256.803709] [038/131] (761s left) syncobj_wait (multi-wait-all-for-submit-signaled) [256.866567] Starting subtest: multi-wait-all-for-submit-signaled [256.868998] Subtest multi-wait-all-for-submit-signaled: SUCCESS (0.000s) [256.956327] [039/131] (761s left) kms_cursor_crc (cursor-onscreen-32x10) [257.106909] Starting subtest: cursor-onscreen-32x10 [257.147487] Subtest cursor-onscreen-32x10: SKIP (0.034s) [257.419249] [040/131] (760s left) gem_render_copy (x-tiled-to-vebox-yf-tiled) [257.474076] Starting subtest: x-tiled-to-vebox-yf-tiled [257.477951] Subtest x-tiled-to-vebox-yf-tiled: SKIP (0.000s) [257.651177] [041/131] (760s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-cpu) [257.759192] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-cpu [257.763221] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [257.878832] [042/131] (760s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area) [262.904488] Starting subtest: pr-overlay-primary-update-sf-dmg-area [262.909651] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s) [263.758348] [043/131] (754s left) kms_draw_crc (draw-method-blt) [263.878094] Starting subtest: draw-method-blt [263.879997] Starting dynamic subtest: xrgb8888-untiled [264.092559] Dynamic subtest xrgb8888-untiled: SUCCESS (0.217s) [264.102955] Starting dynamic subtest: rgb565-untiled [264.293107] Dynamic subtest rgb565-untiled: SUCCESS (0.200s) [264.301842] Starting dynamic subtest: xrgb2101010-untiled [264.470881] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.177s) [264.480580] Starting dynamic subtest: xbgr16161616f-untiled [264.693189] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.222s) [264.703067] Starting dynamic subtest: xrgb8888-xtiled [264.792883] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.100s) [264.802916] Starting dynamic subtest: rgb565-xtiled [264.892713] Dynamic subtest rgb565-xtiled: SUCCESS (0.100s) [264.902584] Starting dynamic subtest: xrgb2101010-xtiled [264.981480] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.088s) [264.990921] Starting dynamic subtest: xbgr16161616f-xtiled [265.081644] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.100s) [265.089059] Starting dynamic subtest: xrgb8888-4tiled [265.192561] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.110s) [265.203143] Starting dynamic subtest: rgb565-4tiled [265.292771] Dynamic subtest rgb565-4tiled: SUCCESS (0.100s) [265.302470] Starting dynamic subtest: xrgb2101010-4tiled [265.381822] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.088s) [265.389895] Starting dynamic subtest: xbgr16161616f-4tiled [265.492616] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.111s) [265.494534] Subtest draw-method-blt: SUCCESS (1.617s) [265.603361] [044/131] (752s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary) [265.716040] Starting subtest: psr-shrfb-scaledprimary [269.355055] Subtest psr-shrfb-scaledprimary: SUCCESS (3.639s) [269.516099] [045/131] (749s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-blt) [269.632614] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-blt [273.104402] Subtest fbc-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (3.476s) [273.248745] [046/131] (745s left) kms_getfb (getfb2-into-addfb2) [273.320349] Starting subtest: getfb2-into-addfb2 [273.322056] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [273.428168] [047/131] (745s left) gem_exec_params (batch-first) [273.485190] Starting subtest: batch-first [273.489923] Subtest batch-first: SUCCESS (0.005s) [273.658819] [048/131] (745s left) kms_big_fb (y-tiled-64bpp-rotate-0) [273.756635] Starting subtest: y-tiled-64bpp-rotate-0 [273.760455] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s) [273.845484] [049/131] (744s left) kms_big_fb (x-tiled-64bpp-rotate-180) [273.953107] Starting subtest: x-tiled-64bpp-rotate-180 [276.255060] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.301s) [276.496367] [050/131] (742s left) gem_exec_flush (basic-uc-pro-default) [276.578440] Starting subtest: basic-uc-pro-default [282.064909] Subtest basic-uc-pro-default: SUCCESS (5.486s) [282.253266] [051/131] (736s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs) [282.350017] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs [282.352375] Starting dynamic subtest: pipe-A-eDP-1 [282.375324] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [282.385108] Starting dynamic subtest: pipe-B-eDP-1 [282.406685] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [282.414697] Starting dynamic subtest: pipe-C-eDP-1 [282.436187] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [282.443891] Starting dynamic subtest: pipe-D-eDP-1 [282.465350] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [282.469656] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.003s) [284.483708] [052/131] (734s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [284.589606] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc [284.594061] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [284.687546] [053/131] (734s left) kms_force_connector_basic (force-connector-state) [284.771554] Starting subtest: force-connector-state [285.367491] Subtest force-connector-state: SUCCESS (0.596s) [286.316277] [054/131] (732s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-onoff) [286.418597] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-onoff [286.423075] Subtest fbcpsr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [286.521975] [055/131] (732s left) kms_psr (fbc-psr2-dpms) [286.620183] Starting subtest: fbc-psr2-dpms [286.622078] Starting dynamic subtest: eDP-1 [286.626267] Dynamic subtest eDP-1: SKIP (0.000s) [286.630329] Subtest fbc-psr2-dpms: SKIP (0.001s) [286.684210] [056/131] (732s left) gem_exec_flush (basic-uc-rw-default) [286.741296] Starting subtest: basic-uc-rw-default [292.219514] Subtest basic-uc-rw-default: SUCCESS (5.480s) [292.403262] [057/131] (726s left) kms_chamelium_hpd (vga-hpd) [292.800628] Subtest vga-hpd: SKIP (0.000s) [293.583842] [058/131] (725s left) gem_softpin (evict-snoop) [293.658088] Starting subtest: evict-snoop [293.662658] Subtest evict-snoop: SKIP (0.000s) [293.774643] [059/131] (725s left) kms_cursor_crc (cursor-rapid-movement-512x512) [294.022892] Starting subtest: cursor-rapid-movement-512x512 [294.027351] Subtest cursor-rapid-movement-512x512: SKIP (0.001s) [294.179326] [060/131] (724s left) gem_softpin (overlap) [294.233770] Starting subtest: overlap [295.080410] Subtest overlap: SUCCESS (0.845s) [295.214029] [061/131] (723s left) gem_exec_whisper (basic-queues-priority) [295.283398] Starting subtest: basic-queues-priority [319.837396] Subtest basic-queues-priority: SUCCESS (24.547s) [320.012447] [062/131] (699s left) i915_hangman (engine-error-state-capture) [320.088232] Starting subtest: engine-error-state-capture [320.090235] Starting dynamic subtest: rcs0 [323.913033] Dynamic subtest rcs0: SUCCESS (3.824s) [323.924899] Starting dynamic subtest: bcs0 [329.865074] Dynamic subtest bcs0: SUCCESS (5.950s) [329.879724] Starting dynamic subtest: vcs0 [335.817372] Dynamic subtest vcs0: SUCCESS (5.950s) [335.829935] Starting dynamic subtest: vcs1 [340.874790] Dynamic subtest vcs1: SUCCESS (5.055s) [340.885295] Starting dynamic subtest: vecs0 [346.825081] Dynamic subtest vecs0: SUCCESS (5.948s) [346.836161] Starting dynamic subtest: ccs0 [351.881946] Dynamic subtest ccs0: SUCCESS (5.054s) [351.885066] Subtest engine-error-state-capture: SUCCESS (31.792s) [352.012325] [063/131] (667s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-blt) [352.115222] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-blt [354.821414] Subtest fbc-1p-primscrn-spr-indfb-draw-blt: SUCCESS (2.710s) [354.965795] [064/131] (664s left) gem_pxp (fail-invalid-protected-context) [355.091940] Starting subtest: fail-invalid-protected-context [355.094160] Subtest fail-invalid-protected-context: SUCCESS (0.000s) [355.205884] [065/131] (664s left) kms_chamelium_hpd (dp-hpd-with-enabled-mode) [355.578903] Subtest dp-hpd-with-enabled-mode: SKIP (0.000s) [356.381393] [066/131] (662s left) syncobj_wait (multi-wait-for-submit-submitted) [356.447682] Starting subtest: multi-wait-for-submit-submitted [356.550400] Subtest multi-wait-for-submit-submitted: SUCCESS (0.103s) [356.623782] [067/131] (662s left) gem_exec_balancer (sequential) [356.686461] Starting subtest: sequential [359.606751] Subtest sequential: SUCCESS (2.920s) [359.933846] [068/131] (659s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [362.078246] Starting subtest: modeset-lpsp-stress-no-wait [372.250341] Subtest modeset-lpsp-stress-no-wait: SUCCESS (10.170s) [372.321843] [069/131] (647s left) kms_psr (pr-sprite-mmap-cpu) [372.424440] Starting subtest: pr-sprite-mmap-cpu [372.428976] Subtest pr-sprite-mmap-cpu: SKIP (0.000s) [372.492402] [070/131] (646s left) device_reset (unbind-reset-rebind) [372.544319] Starting subtest: unbind-reset-rebind [377.249076] Subtest unbind-reset-rebind: SUCCESS (4.700s) [377.285850] [071/131] (642s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted-submitted) [377.339515] Starting subtest: etime-multi-wait-for-submit-unsubmitted-submitted [377.447334] Subtest etime-multi-wait-for-submit-unsubmitted-submitted: SUCCESS (0.107s) [377.518017] [072/131] (642s left) gem_ctx_engines (invalid-engines) [377.595090] Starting subtest: invalid-engines [377.601861] Subtest invalid-engines: SUCCESS (0.007s) [377.835214] [073/131] (641s left) gem_exec_schedule (noreorder-priority) [378.021779] Starting subtest: noreorder-priority [378.024380] Starting dynamic subtest: rcs0 [379.190491] Dynamic subtest rcs0: SUCCESS (1.168s) [379.203415] Starting dynamic subtest: vcs0 [380.930724] Dynamic subtest vcs0: SUCCESS (1.737s) [380.942832] Starting dynamic subtest: vcs1 [382.962372] Dynamic subtest vcs1: SUCCESS (2.030s) [382.974091] Starting dynamic subtest: vecs0 [384.921790] Dynamic subtest vecs0: SUCCESS (1.957s) [384.933075] Starting dynamic subtest: ccs0 [386.103092] Dynamic subtest ccs0: SUCCESS (1.181s) [386.105911] Subtest noreorder-priority: SUCCESS (8.082s) [386.282881] [074/131] (633s left) i915_pm_rps (thresholds) [386.354747] Starting subtest: thresholds [386.359431] Subtest thresholds: SKIP (0.001s) [386.435103] [075/131] (633s left) gem_userptr_blits (set-cache-level) [386.510351] Starting subtest: set-cache-level [386.514679] Subtest set-cache-level: SKIP (0.000s) [386.637351] [076/131] (633s left) gem_render_copy (y-tiled-ccs-to-yf-tiled-mc-ccs) [386.701431] Starting subtest: y-tiled-ccs-to-yf-tiled-mc-ccs [386.705634] Subtest y-tiled-ccs-to-yf-tiled-mc-ccs: SKIP (0.000s) [386.878244] [077/131] (632s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [386.982924] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-cpu [386.987364] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [387.092341] [078/131] (632s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [387.199335] Starting subtest: yf-tiled-16bpp-rotate-0 [387.203612] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [387.291839] [079/131] (632s left) fbdev (unaligned-write) [387.327667] Starting subtest: unaligned-write [387.429571] Subtest unaligned-write: SUCCESS (0.101s) [387.492080] [080/131] (632s left) kms_setmode (basic-clone-single-crtc) [387.555087] Starting subtest: basic-clone-single-crtc [387.561397] Subtest basic-clone-single-crtc: SKIP (0.001s) [387.664141] [081/131] (632s left) kms_psr2_sf (fbc-pr-cursor-plane-update-sf) [392.627680] Starting subtest: fbc-pr-cursor-plane-update-sf [392.632486] Subtest fbc-pr-cursor-plane-update-sf: SKIP (0.002s) [393.478233] [082/131] (626s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt) [393.587498] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt [393.591627] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [393.691750] [083/131] (626s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-gtt) [393.791484] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-gtt [393.795607] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [393.906985] [084/131] (626s left) syncobj_timeline (invalid-transfer-bad-pad) [393.969112] Starting subtest: invalid-transfer-bad-pad [393.971314] Subtest invalid-transfer-bad-pad: SUCCESS (0.000s) [394.086311] [085/131] (625s left) gem_vm_create (isolation) [394.152017] Starting subtest: isolation [394.158480] Subtest isolation: SUCCESS (0.007s) [394.306765] [086/131] (625s left) kms_big_fb (4-tiled-addfb) [394.408390] Starting subtest: 4-tiled-addfb [394.410307] Subtest 4-tiled-addfb: SUCCESS (0.000s) [394.514709] [087/131] (625s left) syncobj_wait (invalid-single-wait-all-unsubmitted) [394.565864] Starting subtest: invalid-single-wait-all-unsubmitted [394.567530] Subtest invalid-single-wait-all-unsubmitted: SUCCESS (0.000s) [394.655606] [088/131] (625s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [395.195070] Starting subtest: syncobj-stationary-timeline-chain-engines [395.285715] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.091s) [396.998426] [089/131] (623s left) kms_properties (plane-properties-legacy) [397.092867] Starting subtest: plane-properties-legacy [397.095490] Starting dynamic subtest: pipe-A-eDP-1 [397.680987] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.585s) [397.689777] Starting dynamic subtest: pipe-B-eDP-1 [398.950329] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.271s) [398.959525] Starting dynamic subtest: pipe-C-eDP-1 [400.173959] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.221s) [400.183886] Starting dynamic subtest: pipe-D-eDP-1 [401.402305] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.228s) [401.404699] Subtest plane-properties-legacy: SUCCESS (4.309s) [402.189926] [090/131] (617s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip) [402.293712] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip [402.298376] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [402.398321] [091/131] (617s left) syncobj_timeline (wait-all-interrupted) [402.461644] Starting subtest: wait-all-interrupted [402.562520] Subtest wait-all-interrupted: SUCCESS (0.102s) [402.640331] [092/131] (617s left) syncobj_timeline (reset-during-wait-for-submit) [402.703490] Starting subtest: reset-during-wait-for-submit [402.806720] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [402.878741] [093/131] (617s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [402.986215] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [407.602136] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (4.617s) [407.720529] [094/131] (612s left) gem_exec_schedule (in-order) [407.796074] Starting subtest: in-order [407.798065] Starting dynamic subtest: rcs0 [407.884395] Dynamic subtest rcs0: SUCCESS (0.097s) [407.896123] Starting dynamic subtest: vcs0 [407.957873] Dynamic subtest vcs0: SUCCESS (0.073s) [407.968426] Starting dynamic subtest: vcs1 [408.036411] Dynamic subtest vcs1: SUCCESS (0.076s) [408.049289] Starting dynamic subtest: vecs0 [408.105457] Dynamic subtest vecs0: SUCCESS (0.068s) [408.117670] Starting dynamic subtest: ccs0 [408.181056] Dynamic subtest ccs0: SUCCESS (0.075s) [408.183844] Subtest in-order: SUCCESS (0.394s) [410.057287] [095/131] (610s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [410.149849] Starting subtest: crc-primary-suspend-yf-tiled-ccs [410.152187] Starting dynamic subtest: pipe-A-eDP-1 [410.161283] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [410.171321] Starting dynamic subtest: pipe-B-eDP-1 [410.179534] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [410.188502] Starting dynamic subtest: pipe-C-eDP-1 [410.197170] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [410.205400] Starting dynamic subtest: pipe-D-eDP-1 [410.214030] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [410.218175] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [412.266189] [096/131] (608s left) gem_madvise (dontneed-before-pwrite) [412.299172] Starting subtest: dontneed-before-pwrite [412.325061] Subtest dontneed-before-pwrite: SKIP (0.023s) [412.380760] [097/131] (608s left) kms_vrr (seamless-rr-switch-drrs) [412.474165] Starting subtest: seamless-rr-switch-drrs [412.480913] Subtest seamless-rr-switch-drrs: SKIP (0.000s) [412.540125] [098/131] (607s left) gem_ctx_persistence (userptr) [412.602364] Starting subtest: userptr [412.803644] Subtest userptr: SUCCESS (0.201s) [412.877581] [099/131] (607s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-pwrite) [412.985623] Starting subtest: psr-2p-primscrn-pri-indfb-draw-pwrite [412.989693] Subtest psr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [413.086364] [100/131] (607s left) kms_addfb_basic (legacy-format) [413.153173] Starting subtest: legacy-format [413.170371] Subtest legacy-format: SUCCESS (0.019s) [413.303048] [101/131] (607s left) kms_ccs (random-ccs-data-4-tiled-mtl-rc-ccs) [413.399738] Starting subtest: random-ccs-data-4-tiled-mtl-rc-ccs [413.401661] Starting dynamic subtest: pipe-A-eDP-1 [414.147651] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s) [414.156936] Starting dynamic subtest: pipe-B-eDP-1 [415.886210] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.736s) [415.896430] Starting dynamic subtest: pipe-C-eDP-1 [417.626676] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.740s) [417.635881] Starting dynamic subtest: pipe-D-eDP-1 [419.448932] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.821s) [419.450900] Subtest random-ccs-data-4-tiled-mtl-rc-ccs: SUCCESS (6.040s) [420.573220] [102/131] (600s left) sw_sync (sync_busy_fork_unixsocket) [420.610116] Starting subtest: sync_busy_fork_unixsocket [420.616594] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s) [420.675356] [103/131] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw) [420.782079] Starting subtest: fbcpsr-2p-pri-indfb-multidraw [420.786191] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s) [420.866638] [104/131] (599s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-msflip-blt) [420.967164] Starting subtest: fbc-2p-scndscrn-shrfb-msflip-blt [420.971169] Subtest fbc-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [421.072681] [105/131] (599s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt) [421.181770] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt [426.354480] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (5.176s) [426.464429] [106/131] (594s left) kms_psr (fbc-pr-sprite-blt) [426.574615] Starting subtest: fbc-pr-sprite-blt [426.579014] Subtest fbc-pr-sprite-blt: SKIP (0.000s) [426.642754] [107/131] (594s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [426.733087] Starting subtest: addfb25-y-tiled-small-legacy [426.737604] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s) [426.831975] [108/131] (593s left) api_intel_bb (simple-bb) [426.891750] Starting subtest: simple-bb [426.896502] Subtest simple-bb: SUCCESS (0.006s) [426.991553] [109/131] (593s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs) [427.089307] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs [427.091621] Starting dynamic subtest: pipe-A-eDP-1 [427.114147] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [427.123376] Starting dynamic subtest: pipe-B-eDP-1 [427.145077] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [427.153656] Starting dynamic subtest: pipe-C-eDP-1 [427.175539] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [427.184019] Starting dynamic subtest: pipe-D-eDP-1 [427.206429] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [427.210508] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s) [429.274340] [110/131] (591s left) gem_exec_balancer (bonded-chain) [429.338810] Starting subtest: bonded-chain [436.162120] Subtest bonded-chain: SUCCESS (6.821s) [436.461435] [111/131] (584s left) kms_invalid_mode (overflow-vrefresh) [436.567298] Starting subtest: overflow-vrefresh [436.569678] Starting dynamic subtest: pipe-A-eDP-1 [436.849666] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.280s) [436.859539] Starting dynamic subtest: pipe-B-eDP-1 [436.861837] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [436.870538] Starting dynamic subtest: pipe-C-eDP-1 [436.872524] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [436.880719] Starting dynamic subtest: pipe-D-eDP-1 [436.882698] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [436.884629] Subtest overflow-vrefresh: SUCCESS (0.286s) [437.697844] [112/131] (583s left) kms_rotation_crc (primary-yf-tiled-reflect-x-90) [437.802299] Starting subtest: primary-yf-tiled-reflect-x-90 [437.807097] Subtest primary-yf-tiled-reflect-x-90: SKIP (0.001s) [437.869659] [113/131] (583s left) syncobj_wait (invalid-reset-illegal-handle) [437.928886] Starting subtest: invalid-reset-illegal-handle [437.931243] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [438.024750] [114/131] (582s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs-cc) [438.114056] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs-cc [438.116279] Starting dynamic subtest: pipe-A-eDP-1 [438.138496] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [438.147472] Starting dynamic subtest: pipe-B-eDP-1 [438.168265] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [438.176890] Starting dynamic subtest: pipe-C-eDP-1 [438.198031] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [438.207513] Starting dynamic subtest: pipe-D-eDP-1 [438.229036] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [438.233609] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [440.267795] [115/131] (580s left) kms_rotation_crc (primary-rotation-180) [440.365127] Starting subtest: primary-rotation-180 [447.202745] Subtest primary-rotation-180: SUCCESS (6.837s) [448.414233] [116/131] (572s left) syncobj_wait (wait-for-submit-snapshot) [448.466386] Starting subtest: wait-for-submit-snapshot [448.548949] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [448.623873] [117/131] (572s left) gem_exec_fence (basic-busy-all) [448.685525] Starting subtest: basic-busy-all [448.792330] Subtest basic-busy-all: SUCCESS (0.107s) [451.027827] [118/131] (570s left) gem_ctx_isolation (preservation-s3) [451.083982] Starting subtest: preservation-S3 [451.086182] Starting dynamic subtest: rcs0 [467.619501] Dynamic subtest rcs0: SUCCESS (1.600s) [467.631797] Starting dynamic subtest: bcs0 [483.512502] Dynamic subtest bcs0: SUCCESS (1.435s) [483.525045] Starting dynamic subtest: vcs0 [499.524172] Dynamic subtest vcs0: SUCCESS (2.923s) [499.535779] Starting dynamic subtest: vcs1 [517.589084] Dynamic subtest vcs1: SUCCESS (5.133s) [517.600524] Starting dynamic subtest: vecs0 [535.588273] Dynamic subtest vecs0: SUCCESS (5.080s) [535.606263] Starting dynamic subtest: ccs0 [553.505305] Dynamic subtest ccs0: SUCCESS (3.134s) [553.507536] Subtest preservation-S3: SUCCESS (19.310s) [553.757908] [119/131] (550s left) kms_plane_scaling (planes-upscale-20x20) [553.855755] Starting subtest: planes-upscale-20x20 [553.857963] Starting dynamic subtest: pipe-A [553.920800] Dynamic subtest pipe-A: SUCCESS (0.066s) [553.932109] Starting dynamic subtest: pipe-B [555.030243] Dynamic subtest pipe-B: SUCCESS (1.128s) [555.042689] Starting dynamic subtest: pipe-C [556.119226] Dynamic subtest pipe-C: SUCCESS (1.105s) [556.130327] Starting dynamic subtest: pipe-D [557.236349] Dynamic subtest pipe-D: SUCCESS (1.131s) [557.238618] Subtest planes-upscale-20x20: SUCCESS (3.431s) [558.376050] [120/131] (545s left) kms_flip (2x-blocking-wf_vblank) [558.476911] Starting subtest: 2x-blocking-wf_vblank [558.489791] Subtest 2x-blocking-wf_vblank: SKIP (0.012s) [558.601786] [121/131] (545s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-pgflip-blt) [558.706150] Starting subtest: fbcpsr-2p-primscrn-shrfb-pgflip-blt [558.710251] Subtest fbcpsr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [558.813076] [122/131] (545s left) kms_flip (2x-dpms-vs-vblank-race) [558.905776] Starting subtest: 2x-dpms-vs-vblank-race [558.916220] Subtest 2x-dpms-vs-vblank-race: SKIP (0.010s) [559.037957] [123/131] (545s left) kms_content_protection (dp-mst-lic-type-0) [559.218691] Starting subtest: dp-mst-lic-type-0 [559.223779] Subtest dp-mst-lic-type-0: SKIP (0.000s) [559.350484] [124/131] (545s left) api_intel_allocator (reopen) [559.405176] Starting subtest: reopen [559.408936] Subtest reopen: SUCCESS (0.005s) [559.526024] [125/131] (544s left) prime_self_import (basic-with_one_bo_two_files) [559.563816] Starting subtest: basic-with_one_bo_two_files [559.574081] Subtest basic-with_one_bo_two_files: SUCCESS (0.017s) [559.675975] [126/131] (544s left) gen9_exec_parse (bb-start-cmd) [559.734569] Subtest bb-start-cmd: SKIP (0.000s) [559.811034] [127/131] (544s left) gem_lmem_evict (dontneed-evict-race) [559.850742] Subtest dontneed-evict-race: SKIP (0.000s) [559.887279] [128/131] (544s left) gem_fence_thrash (bo-write-verify-threaded-none) [559.920447] Starting subtest: bo-write-verify-threaded-none [559.947392] Subtest bo-write-verify-threaded-none: SKIP (0.025s) [560.017651] [129/131] (544s left) kms_lease (lessee-list) [560.113064] Starting subtest: lessee-list [560.114986] Starting dynamic subtest: pipe-A-eDP-1 [560.116984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s) [560.128183] Starting dynamic subtest: pipe-B-eDP-1 [560.130017] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [560.139494] Starting dynamic subtest: pipe-C-eDP-1 [560.141395] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [560.150745] Starting dynamic subtest: pipe-D-eDP-1 [560.152578] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [560.154447] Subtest lessee-list: SUCCESS (0.008s) [560.227581] [130/131] (544s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation) [560.314262] Starting subtest: plane-upscale-factor-0-25-with-rotation [560.316207] Starting dynamic subtest: pipe-A [560.540019] Dynamic subtest pipe-A: SUCCESS (0.227s) [560.549921] Starting dynamic subtest: pipe-B [561.831989] Dynamic subtest pipe-B: SUCCESS (1.301s) [561.841322] Starting dynamic subtest: pipe-C [563.146922] Dynamic subtest pipe-C: SUCCESS (1.322s) [563.158377] Starting dynamic subtest: pipe-D [564.468783] Dynamic subtest pipe-D: SUCCESS (1.327s) [564.471115] Subtest plane-upscale-factor-0-25-with-rotation: SUCCESS (4.180s) [565.635320] [131/131] (538s left) gem_mmap_gtt (cpuset-big-copy) [565.704011] Subtest cpuset-big-copy: SKIP (0.000s) [565.747732] Closing watchdogs Done.