[59.539253] Initializing watchdogs [59.539300] /dev/watchdog0 [59.554735] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [59.558864] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.560993] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.564325] [001/133] (960s left) perf (gen12-oa-tlb-invalidate) [59.717381] Starting subtest: gen12-oa-tlb-invalidate [59.719167] Starting dynamic subtest: 0-rcs0 [69.772750] Dynamic subtest 0-rcs0: SUCCESS (10.054s) [69.779584] Starting dynamic subtest: 1-vcs0 [79.818104] Dynamic subtest 1-vcs0: SUCCESS (10.046s) [79.820682] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.101s) [79.855564] [002/133] (940s left) gem_ctx_param (invalid-set-no-zeromap) [79.902911] Starting subtest: invalid-set-no-zeromap [79.905679] Subtest invalid-set-no-zeromap: SUCCESS (0.000s) [79.973565] [003/133] (940s left) gem_exec_params (invalid-flag) [80.035060] Starting subtest: invalid-flag [80.037229] Subtest invalid-flag: SUCCESS (0.000s) [80.135177] [004/133] (940s left) kms_plane (plane-panning-bottom-right-suspend) [80.232756] Starting subtest: plane-panning-bottom-right-suspend [80.235056] Starting dynamic subtest: pipe-A [98.040418] Dynamic subtest pipe-A: SUCCESS (3.004s) [98.049300] Starting dynamic subtest: pipe-B [116.973344] Dynamic subtest pipe-B: SUCCESS (3.534s) [116.975507] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.540s) [117.783090] [005/133] (902s left) gem_exec_nop (basic-sequential) [117.863957] Starting subtest: basic-sequential [132.631065] Subtest basic-sequential: SUCCESS (14.781s) [132.846173] [006/133] (887s left) kms_vblank (query-forked) [132.952575] Starting subtest: query-forked [132.954849] Starting dynamic subtest: pipe-A-eDP-1 [134.763346] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.812s) [134.781598] Starting dynamic subtest: pipe-D-eDP-1 [137.309876] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.543s) [137.312088] Subtest query-forked: SUCCESS (4.358s) [138.142624] [007/133] (882s left) kms_busy (extended-pageflip-hang-oldfb) [138.250286] Starting subtest: extended-pageflip-hang-oldfb [138.252781] Starting dynamic subtest: pipe-A [138.699570] Dynamic subtest pipe-A: SUCCESS (0.446s) [138.711998] Starting dynamic subtest: pipe-D [139.852275] Dynamic subtest pipe-D: SUCCESS (1.151s) [139.854606] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.601s) [140.708733] [008/133] (879s left) i915_module_load (reload) [140.748839] Starting subtest: reload [143.924637] Subtest reload: SUCCESS (3.178s) [143.961991] [009/133] (876s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [145.144954] Starting subtest: basic-busy-flip-before-cursor-atomic [145.149603] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [145.289326] [010/133] (875s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [145.389170] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [152.778355] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.394s) [152.887917] [011/133] (867s left) kms_cursor_crc (cursor-size-change) [152.981764] Starting subtest: cursor-size-change [152.983956] Starting dynamic subtest: pipe-A-eDP-1 [153.793888] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.811s) [153.803054] Starting dynamic subtest: pipe-D-eDP-1 [155.276653] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.480s) [155.278711] Subtest cursor-size-change: SUCCESS (2.294s) [156.086644] [012/133] (864s left) gem_exec_schedule (preemptive-hang) [156.261337] Starting subtest: preemptive-hang [156.263726] Starting dynamic subtest: rcs0 [165.248418] Dynamic subtest rcs0: SUCCESS (8.990s) [165.259883] Starting dynamic subtest: bcs0 [174.201905] Dynamic subtest bcs0: SUCCESS (8.952s) [174.215024] Starting dynamic subtest: vcs0 [183.287720] Dynamic subtest vcs0: SUCCESS (9.086s) [183.295447] Starting dynamic subtest: vcs1 [192.247022] Dynamic subtest vcs1: SUCCESS (8.957s) [192.257880] Starting dynamic subtest: vecs0 [201.207693] Dynamic subtest vecs0: SUCCESS (8.962s) [201.223517] Starting dynamic subtest: ccs0 [210.235621] Dynamic subtest ccs0: SUCCESS (9.029s) [210.237985] Subtest preemptive-hang: SUCCESS (53.981s) [210.490201] [013/133] (810s left) kms_cursor_edge_walk (256x256-top-edge) [210.597676] Starting subtest: 256x256-top-edge [210.600003] Starting dynamic subtest: pipe-A-eDP-1 [214.034393] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.437s) [214.044104] Starting dynamic subtest: pipe-D-eDP-1 [217.162068] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s) [217.164464] Subtest 256x256-top-edge: SUCCESS (6.565s) [217.961671] [014/133] (802s left) gem_render_copy (yf-tiled-ccs-to-linear) [218.038874] Starting subtest: yf-tiled-ccs-to-linear [218.043500] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [218.231966] [015/133] (802s left) i915_drm_fdinfo (memory-info-shared) [218.271422] Starting subtest: memory-info-shared [218.273781] Starting dynamic subtest: smem0 [218.324036] Dynamic subtest smem0: SUCCESS (0.053s) [218.326626] Subtest memory-info-shared: SUCCESS (0.054s) [218.396073] [016/133] (802s left) kms_plane (pixel-format-x-tiled-modifier) [218.485789] Starting subtest: pixel-format-x-tiled-modifier [218.510686] Starting dynamic subtest: pipe-A-plane-0 [219.132550] Dynamic subtest pipe-A-plane-0: SUCCESS (0.622s) [219.142054] Starting dynamic subtest: pipe-A-plane-3 [219.554507] Dynamic subtest pipe-A-plane-3: SUCCESS (0.422s) [219.563402] Starting dynamic subtest: pipe-A-plane-5 [219.566891] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [220.649444] Starting dynamic subtest: pipe-B-plane-0 [221.271164] Dynamic subtest pipe-B-plane-0: SUCCESS (0.633s) [221.279946] Starting dynamic subtest: pipe-B-plane-3 [221.670992] Dynamic subtest pipe-B-plane-3: SUCCESS (0.399s) [221.680683] Starting dynamic subtest: pipe-B-plane-5 [221.684207] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [221.987252] Subtest pixel-format-x-tiled-modifier: SUCCESS (3.503s) [222.827586] [017/133] (797s left) perf_pmu (enable-race) [222.865153] Starting subtest: enable-race [222.867494] Starting dynamic subtest: rcs0 [235.629061] Dynamic subtest rcs0: SUCCESS (12.763s) [235.638989] Starting dynamic subtest: bcs0 [248.370168] Dynamic subtest bcs0: SUCCESS (12.739s) [248.381577] Starting dynamic subtest: vcs0 [264.082663] Dynamic subtest vcs0: SUCCESS (15.709s) [264.101118] Starting dynamic subtest: vcs1 [280.082178] Dynamic subtest vcs1: SUCCESS (15.998s) [280.093090] Starting dynamic subtest: vecs0 [296.080875] Dynamic subtest vecs0: SUCCESS (15.999s) [296.092038] Starting dynamic subtest: ccs0 [308.834750] Dynamic subtest ccs0: SUCCESS (12.753s) [308.837489] Subtest enable-race: SUCCESS (85.971s) [308.940424] [018/133] (711s left) perf_pmu (all-busy-idle-check-all) [308.976139] Starting subtest: all-busy-idle-check-all [310.098355] Subtest all-busy-idle-check-all: SUCCESS (1.122s) [310.182053] [019/133] (710s left) syncobj_wait (invalid-multi-wait-unsubmitted) [310.239004] Starting subtest: invalid-multi-wait-unsubmitted [310.241368] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s) [310.319379] [020/133] (710s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [310.375698] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [310.378011] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [310.486073] [021/133] (710s left) kms_psr (pr-sprite-plane-move) [310.578683] Starting subtest: pr-sprite-plane-move [310.582776] Subtest pr-sprite-plane-move: SKIP (0.000s) [310.648530] [022/133] (710s left) gem_mmap_gtt (bad-object) [310.712975] Subtest bad-object: SKIP (0.000s) [310.763280] [023/133] (710s left) kms_flip (flip-vs-rmfb) [310.859101] Starting subtest: flip-vs-rmfb [310.861440] Starting dynamic subtest: A-eDP1 [319.495796] Dynamic subtest A-eDP1: SUCCESS (8.636s) [319.508482] Starting dynamic subtest: B-eDP1 [328.129930] Dynamic subtest B-eDP1: SUCCESS (8.632s) [328.137885] Starting dynamic subtest: C-eDP1 [336.782774] Dynamic subtest C-eDP1: SUCCESS (8.651s) [336.793850] Starting dynamic subtest: D-eDP1 [345.486654] Dynamic subtest D-eDP1: SUCCESS (8.700s) [345.492052] Subtest flip-vs-rmfb: SUCCESS (34.633s) [346.681120] [024/133] (674s left) kms_rotation_crc (primary-rotation-90) [346.775093] Starting subtest: primary-rotation-90 [346.779094] Subtest primary-rotation-90: SKIP (0.001s) [346.849106] [025/133] (674s left) kms_cdclk (plane-scaling) [346.935997] Starting subtest: plane-scaling [346.938212] Starting dynamic subtest: pipe-A-eDP-1 [347.227189] Dynamic subtest pipe-A-eDP-1: SKIP (0.290s) [347.236559] Starting dynamic subtest: pipe-B-eDP-1 [347.241251] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [347.250189] Starting dynamic subtest: pipe-C-eDP-1 [347.254914] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [347.263480] Starting dynamic subtest: pipe-D-eDP-1 [347.267987] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [347.272427] Subtest plane-scaling: SKIP (0.298s) [348.014789] [026/133] (672s left) kms_big_fb (4-tiled-64bpp-rotate-270) [348.120247] Starting subtest: 4-tiled-64bpp-rotate-270 [348.140341] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.019s) [348.240946] [027/133] (672s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [348.333429] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [354.862245] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.529s) [355.010339] [028/133] (666s left) gem_eio (in-flight-1us) [355.215587] Starting subtest: in-flight-1us [363.722407] Subtest in-flight-1us: SUCCESS (8.505s) [363.864973] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true [363.868130] [029/133] (657s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-pwrite) [363.960598] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-pwrite [369.242076] Subtest fbc-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (5.285s) [370.379144] [030/133] (650s left) kms_pm_rpm (modeset-lpsp-stress-no-wait) [372.319556] Starting subtest: modeset-lpsp-stress-no-wait [382.156035] Subtest modeset-lpsp-stress-no-wait: SUCCESS (9.837s) [382.243671] [031/133] (638s left) kms_plane_multiple (tiling-y) [382.338960] Starting subtest: tiling-y [382.343160] Subtest tiling-y: SKIP (0.000s) [382.409489] [032/133] (638s left) kms_addfb_basic (framebuffer-vs-set-tiling) [382.470367] Starting subtest: framebuffer-vs-set-tiling [382.474889] Subtest framebuffer-vs-set-tiling: SKIP (0.000s) [382.596067] [033/133] (638s left) kms_cursor_legacy (torture-move) [382.719422] Starting subtest: torture-move [382.721596] Starting dynamic subtest: pipe-A [388.694632] Dynamic subtest pipe-A: SUCCESS (5.970s) [388.707118] Starting dynamic subtest: pipe-B [395.401744] Dynamic subtest pipe-B: SUCCESS (6.705s) [395.413368] Starting dynamic subtest: pipe-C [401.579593] Dynamic subtest pipe-C: SUCCESS (6.175s) [401.596307] Starting dynamic subtest: pipe-D [408.209305] Dynamic subtest pipe-D: SUCCESS (6.627s) [408.220992] Starting dynamic subtest: all-pipes [413.975691] Dynamic subtest all-pipes: SUCCESS (5.765s) [413.977984] Subtest torture-move: SUCCESS (31.252s) [414.135876] [034/133] (607s left) kms_psr (psr2-cursor-plane-move) [414.243706] Starting subtest: psr2-cursor-plane-move [414.245875] Starting dynamic subtest: eDP-1 [415.990316] Dynamic subtest eDP-1: SUCCESS (1.746s) [415.992664] Subtest psr2-cursor-plane-move: SUCCESS (1.748s) [416.786544] [035/133] (604s left) kms_big_fb (linear-64bpp-rotate-270) [416.890342] Starting subtest: linear-64bpp-rotate-270 [416.917982] Subtest linear-64bpp-rotate-270: SKIP (0.026s) [417.035267] [036/133] (604s left) gem_exec_alignment (forked) [417.093545] Starting subtest: forked [454.621150] Subtest forked: SUCCESS (37.525s) [455.438215] [037/133] (566s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling) [455.575147] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling [455.579670] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.000s) [455.660060] [038/133] (565s left) syncobj_timeline (etime-single-wait-for-submit-unsubmitted) [455.719673] Starting subtest: etime-single-wait-for-submit-unsubmitted [455.822171] Subtest etime-single-wait-for-submit-unsubmitted: SUCCESS (0.101s) [455.901823] [039/133] (565s left) syncobj_timeline (wait-for-submit-snapshot) [455.956441] Starting subtest: wait-for-submit-snapshot [456.040724] Subtest wait-for-submit-snapshot: SUCCESS (0.083s) [456.120190] [040/133] (565s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-mmap-gtt) [456.223365] Starting subtest: psr-2p-primscrn-pri-indfb-draw-mmap-gtt [456.227419] Subtest psr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [456.339366] [041/133] (565s left) kms_pipe_stress (stress-xrgb8888-ytiled) [456.426492] Starting subtest: stress-xrgb8888-ytiled [456.430956] Subtest stress-xrgb8888-ytiled: SKIP (0.000s) [456.499305] [042/133] (565s left) kms_lease (setcrtc-implicit-plane) [456.584106] Starting subtest: setcrtc-implicit-plane [456.586094] Starting dynamic subtest: pipe-A-eDP-1 [457.062441] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.479s) [457.072670] Starting dynamic subtest: pipe-B-eDP-1 [458.206405] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s) [458.218832] Starting dynamic subtest: pipe-C-eDP-1 [459.333576] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s) [459.343126] Starting dynamic subtest: pipe-D-eDP-1 [460.455198] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.121s) [460.457546] Subtest setcrtc-implicit-plane: SUCCESS (3.874s) [461.300173] [043/133] (560s left) perf_pmu (interrupts-sync) [461.343429] Starting subtest: interrupts-sync [462.445058] Subtest interrupts-sync: SUCCESS (1.100s) [462.560239] [044/133] (559s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible) [462.652169] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible [462.663465] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s) [462.740110] [045/133] (559s left) syncobj_wait (wait-any-interrupted) [462.793422] Starting subtest: wait-any-interrupted [462.894241] Subtest wait-any-interrupted: SUCCESS (0.102s) [462.971201] [046/133] (558s left) kms_content_protection (uevent-hdcp14) [463.108471] Starting subtest: uevent-hdcp14 [463.113073] Subtest uevent-hdcp14: SKIP (0.000s) [463.220216] [047/133] (558s left) kms_ccs (bad-rotation-90-y-tiled-gen12-rc-ccs) [463.310940] Starting subtest: bad-rotation-90-y-tiled-gen12-rc-ccs [463.313143] Starting dynamic subtest: pipe-A-eDP-1 [463.335706] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [463.346916] Starting dynamic subtest: pipe-B-eDP-1 [463.368236] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [463.376988] Starting dynamic subtest: pipe-C-eDP-1 [463.398385] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [463.406901] Starting dynamic subtest: pipe-D-eDP-1 [463.428868] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [463.433115] Subtest bad-rotation-90-y-tiled-gen12-rc-ccs: SKIP (0.004s) [465.469610] [048/133] (556s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [465.558313] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [472.536470] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (6.982s) [473.676877] [049/133] (548s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs) [473.765710] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs [473.767725] Starting dynamic subtest: pipe-A-eDP-1 [473.927983] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.155s) [473.939589] Starting dynamic subtest: pipe-B-eDP-1 [473.958630] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [473.967848] Starting dynamic subtest: pipe-C-eDP-1 [473.985990] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [473.994815] Starting dynamic subtest: pipe-D-eDP-1 [474.013691] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s) [474.015538] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SUCCESS (0.165s) [476.260057] [050/133] (545s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [476.353620] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [476.357979] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [476.459917] [051/133] (545s left) kms_big_fb (x-tiled-8bpp-rotate-90) [476.561245] Starting subtest: x-tiled-8bpp-rotate-90 [476.583003] Subtest x-tiled-8bpp-rotate-90: SKIP (0.021s) [476.699172] [052/133] (545s left) gem_exec_fence (syncobj-timeline-unused-fence) [477.254428] Starting subtest: syncobj-timeline-unused-fence [477.260697] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s) [478.176861] [053/133] (543s left) kms_color (gamma) [478.273875] Starting subtest: gamma [478.276011] Starting dynamic subtest: pipe-A-eDP-1 [479.018992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.746s) [479.030956] Starting dynamic subtest: pipe-B-eDP-1 [480.440372] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.419s) [480.450717] Starting dynamic subtest: pipe-C-eDP-1 [481.826857] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.388s) [481.836213] Starting dynamic subtest: pipe-D-eDP-1 [483.147736] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.318s) [483.150109] Subtest gamma: SUCCESS (4.874s) [483.971568] [054/133] (538s left) gem_exec_reloc (basic-wc-read-noreloc) [484.038462] Subtest basic-wc-read-noreloc: SKIP (0.000s) [484.122769] [055/133] (538s left) syncobj_wait (invalid-single-wait-unsubmitted) [484.181671] Starting subtest: invalid-single-wait-unsubmitted [484.183864] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s) [484.296153] [056/133] (537s left) kms_cursor_crc (cursor-sliding-128x42) [484.520563] Starting subtest: cursor-sliding-128x42 [484.574868] Subtest cursor-sliding-128x42: SKIP (0.049s) [484.783401] [057/133] (537s left) i915_suspend (forcewake) [484.846840] Starting subtest: forcewake [516.615018] Subtest forcewake: SUCCESS (2.301s) [517.685914] [058/133] (505s left) kms_big_fb (y-tiled-16bpp-rotate-90) [517.790827] Starting subtest: y-tiled-16bpp-rotate-90 [517.795325] Subtest y-tiled-16bpp-rotate-90: SKIP (0.000s) [517.904260] [059/133] (505s left) gem_create (create-ext-placement-all) [518.084730] Starting subtest: create-ext-placement-all [518.087260] Subtest create-ext-placement-all: SUCCESS (0.000s) [518.190930] [060/133] (505s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [518.298529] Starting subtest: psr-rgb565-draw-mmap-cpu [525.024842] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (6.731s) [525.125558] [061/133] (498s left) syncobj_timeline (multi-wait-all-signaled) [525.182539] Starting subtest: multi-wait-all-signaled [525.184835] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [525.275431] [062/133] (498s left) gem_exec_reloc (basic-wc-noreloc) [525.337120] Subtest basic-wc-noreloc: SKIP (0.000s) [525.407679] [063/133] (498s left) gen3_render_tiledy_blits [525.513549] [064/133] (498s left) kms_plane_scaling (planes-upscale-20x20) [525.601455] Starting subtest: planes-upscale-20x20 [525.604491] Starting dynamic subtest: pipe-A [525.661928] Dynamic subtest pipe-A: SUCCESS (0.062s) [525.673860] Starting dynamic subtest: pipe-B [526.811488] Dynamic subtest pipe-B: SUCCESS (1.148s) [526.822377] Starting dynamic subtest: pipe-C [527.914596] Dynamic subtest pipe-C: SUCCESS (1.101s) [527.924104] Starting dynamic subtest: pipe-D [529.066668] Dynamic subtest pipe-D: SUCCESS (1.151s) [529.068921] Subtest planes-upscale-20x20: SUCCESS (3.468s) [530.217795] [065/133] (493s left) kms_addfb_basic (unused-offsets) [530.277851] Starting subtest: unused-offsets [530.279821] Subtest unused-offsets: SUCCESS (0.000s) [530.414808] [066/133] (493s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [530.505861] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [537.149847] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.646s) [537.278760] [067/133] (486s left) gem_lmem_swapping (parallel-random) [537.321145] Subtest parallel-random: SKIP (0.000s) [537.367833] [068/133] (486s left) gem_exec_whisper (basic-queues) [537.429915] Starting subtest: basic-queues [544.520305] Subtest basic-queues: SUCCESS (7.088s) [544.704170] [069/133] (479s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [544.793167] Starting subtest: crc-primary-suspend-yf-tiled-ccs [544.795460] Starting dynamic subtest: pipe-A-eDP-1 [544.803939] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [544.813509] Starting dynamic subtest: pipe-B-eDP-1 [544.822668] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [544.832455] Starting dynamic subtest: pipe-C-eDP-1 [544.840755] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [544.850483] Starting dynamic subtest: pipe-D-eDP-1 [544.858587] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [544.862691] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.005s) [547.100500] [070/133] (476s left) kms_atomic_interruptible (universal-setplane-primary) [547.221710] Starting subtest: universal-setplane-primary [547.224063] Starting dynamic subtest: pipe-A-eDP-1 [554.626647] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.403s) [554.629023] Subtest universal-setplane-primary: SUCCESS (7.404s) [555.454916] [071/133] (468s left) kms_panel_fitting (atomic-fastset) [555.553326] Starting subtest: atomic-fastset [555.555172] Starting dynamic subtest: pipe-A-eDP-1 [555.691846] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s) [555.704347] Starting dynamic subtest: pipe-B-eDP-1 [556.915589] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.223s) [556.929010] Starting dynamic subtest: pipe-C-eDP-1 [558.099176] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s) [558.109477] Starting dynamic subtest: pipe-D-eDP-1 [559.234114] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [559.236447] Subtest atomic-fastset: SUCCESS (3.682s) [560.504741] [072/133] (463s left) gem_create (create-valid-nonaligned) [560.558028] Starting subtest: create-valid-nonaligned [560.560267] Subtest create-valid-nonaligned: SUCCESS (0.000s) [560.743319] [073/133] (463s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [560.846736] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [561.848518] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.002s) [561.960786] [074/133] (462s left) kms_rotation_crc (cursor-rotation-180) [562.064353] Starting subtest: cursor-rotation-180 [563.562424] Subtest cursor-rotation-180: SUCCESS (1.500s) [564.750770] [075/133] (459s left) syncobj_wait (invalid-signal-illegal-handle) [564.804426] Starting subtest: invalid-signal-illegal-handle [564.806759] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [564.914710] [076/133] (459s left) kms_cursor_crc (cursor-onscreen-256x85) [565.182586] Starting subtest: cursor-onscreen-256x85 [565.233350] Subtest cursor-onscreen-256x85: SKIP (0.043s) [565.418460] [077/133] (458s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc) [565.515312] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc [565.517636] Starting dynamic subtest: pipe-A-eDP-1 [565.575016] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [565.585204] Starting dynamic subtest: pipe-B-eDP-1 [565.643271] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s) [565.654826] Starting dynamic subtest: pipe-C-eDP-1 [565.706553] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [565.716912] Starting dynamic subtest: pipe-D-eDP-1 [565.765656] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [565.769469] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.013s) [567.739069] [078/133] (456s left) fbdev (info) [567.773430] Starting subtest: info [567.775700] Subtest info: SUCCESS (0.000s) [567.838413] [079/133] (456s left) gem_linear_blits (normal) [568.008432] Starting subtest: normal [571.661036] Subtest normal: SUCCESS (3.651s) [571.789280] [080/133] (452s left) sw_sync (sync_merge) [571.878234] Starting subtest: sync_merge [571.880670] Subtest sync_merge: SUCCESS (0.000s) [571.959994] [081/133] (452s left) kms_prop_blob (blob-prop-lifetime) [572.004093] Starting subtest: blob-prop-lifetime [572.006399] Subtest blob-prop-lifetime: SUCCESS (0.003s) [572.117006] [082/133] (452s left) gem_exec_flush (basic-wb-rw-default) [572.177305] Starting subtest: basic-wb-rw-default [577.658741] Subtest basic-wb-rw-default: SUCCESS (5.481s) [577.850789] [083/133] (446s left) kms_pm_lpsp (kms-lpsp) [578.962044] Starting subtest: kms-lpsp [578.964263] Starting dynamic subtest: pipe-A-eDP-1 [579.142356] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.184s) [579.438181] Subtest kms-lpsp: SUCCESS (0.478s) [580.260057] [084/133] (444s left) kms_psr (fbc-pr-primary-render) [580.349550] Starting subtest: fbc-pr-primary-render [580.354010] Subtest fbc-pr-primary-render: SKIP (0.000s) [580.428257] [085/133] (444s left) kms_psr2_sf (fbc-psr2-cursor-plane-update-sf) [580.535379] Starting subtest: fbc-psr2-cursor-plane-update-sf [580.537489] Starting dynamic subtest: pipe-A-eDP-1 [580.610076] Dynamic subtest pipe-A-eDP-1: SKIP (0.078s) [580.620159] Starting dynamic subtest: pipe-B-eDP-1 [581.735482] Dynamic subtest pipe-B-eDP-1: SKIP (1.123s) [581.739792] Subtest fbc-psr2-cursor-plane-update-sf: SKIP (1.204s) [582.930092] [086/133] (441s left) gem_exec_schedule (u-semaphore-noskip) [583.010522] Starting subtest: u-semaphore-noskip [583.404992] Subtest u-semaphore-noskip: SUCCESS (0.401s) [583.755083] [087/133] (440s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled) [583.815833] Starting subtest: invalid-multi-wait-unsubmitted-signaled [583.818180] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [583.920679] [088/133] (440s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [584.012330] Starting subtest: blocking-absolute-wf_vblank-interruptible [584.014223] Starting dynamic subtest: A-eDP1 [592.694908] Dynamic subtest A-eDP1: SUCCESS (8.681s) [592.708783] Starting dynamic subtest: B-eDP1 [601.429444] Dynamic subtest B-eDP1: SUCCESS (8.732s) [601.445158] Starting dynamic subtest: C-eDP1 [610.142211] Dynamic subtest C-eDP1: SUCCESS (8.710s) [610.154201] Starting dynamic subtest: D-eDP1 [618.876809] Dynamic subtest D-eDP1: SUCCESS (8.732s) [618.881967] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (34.870s) [620.093643] [089/133] (404s left) gem_exec_fence (submit3) [620.269114] Starting subtest: submit3 [620.274181] Subtest submit3: SKIP (0.000s) [621.623396] [090/133] (403s left) gem_mmap_offset (partial-mmap) [621.672243] Starting subtest: partial-mmap [621.674674] Starting dynamic subtest: smem0 [621.679857] Dynamic subtest smem0: SUCCESS (0.007s) [621.682115] Subtest partial-mmap: SUCCESS (0.009s) [621.809149] [091/133] (402s left) gem_softpin (allocator-basic-reserve) [621.877129] Starting subtest: allocator-basic-reserve [621.947718] Subtest allocator-basic-reserve: SUCCESS (0.070s) [622.062830] [092/133] (402s left) syncobj_timeline (invalid-signal-illegal-handle) [622.107396] Starting subtest: invalid-signal-illegal-handle [622.109685] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [622.193851] [093/133] (402s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [622.290023] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [629.573765] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.286s) [629.725019] [094/133] (395s left) syncobj_timeline (wait-all-delayed-signal) [629.783040] Starting subtest: wait-all-delayed-signal [629.884326] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [629.966760] [095/133] (394s left) kms_async_flips (test-cursor-atomic) [630.059526] Starting subtest: test-cursor-atomic [630.437777] Starting dynamic subtest: pipe-A-eDP-1 [631.189460] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.752s) [631.579907] Starting dynamic subtest: pipe-B-eDP-1 [632.319934] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.748s) [632.718659] Starting dynamic subtest: pipe-C-eDP-1 [633.448053] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.751s) [633.818038] Starting dynamic subtest: pipe-D-eDP-1 [634.583566] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.774s) [634.585906] Subtest test-cursor-atomic: SUCCESS (4.526s) [635.785986] [096/133] (389s left) api_intel_bb (render) [635.841146] Starting subtest: render [635.843536] Starting dynamic subtest: render-none-512 [635.939751] Dynamic subtest render-none-512: SUCCESS (0.100s) [635.952353] Starting dynamic subtest: render-none-1024 [636.320111] Dynamic subtest render-none-1024: SUCCESS (0.378s) [636.332585] Starting dynamic subtest: render-x-512 [636.406487] Dynamic subtest render-x-512: SUCCESS (0.086s) [636.418740] Starting dynamic subtest: render-x-1024 [636.741113] Dynamic subtest render-x-1024: SUCCESS (0.332s) [636.753963] Starting dynamic subtest: render-y-512 [636.826149] Dynamic subtest render-y-512: SUCCESS (0.085s) [636.837957] Starting dynamic subtest: render-y-1024 [637.169006] Dynamic subtest render-y-1024: SUCCESS (0.340s) [637.171744] Subtest render: SUCCESS (1.329s) [637.274165] [097/133] (387s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc) [637.370227] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc [637.374607] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [637.467838] [098/133] (387s left) gen7_exec_parse (chained-batch) [637.523598] Subtest chained-batch: SKIP (0.000s) [637.583110] [099/133] (387s left) gem_userptr_blits (map-fixed-invalidate) [637.654466] Starting subtest: map-fixed-invalidate [637.658700] Subtest map-fixed-invalidate: SKIP (0.000s) [637.767120] [100/133] (387s left) kms_universal_plane (universal-plane-pageflip-windowed) [637.847773] Starting subtest: universal-plane-pageflip-windowed [637.850158] Starting dynamic subtest: pipe-A-eDP-1 [638.445458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.598s) [638.455238] Starting dynamic subtest: pipe-B-eDP-1 [639.694098] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.244s) [639.704578] Starting dynamic subtest: pipe-C-eDP-1 [640.909730] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.216s) [640.921240] Starting dynamic subtest: pipe-D-eDP-1 [642.134019] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s) [642.136232] Subtest universal-plane-pageflip-windowed: SUCCESS (4.287s) [642.987331] [101/133] (382s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-sf) [643.089313] Starting subtest: psr2-overlay-plane-move-continuous-sf [643.091616] Starting dynamic subtest: pipe-A-eDP-1 [649.054911] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.968s) [649.068349] Starting dynamic subtest: pipe-B-eDP-1 [655.773716] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.718s) [655.776016] Subtest psr2-overlay-plane-move-continuous-sf: SUCCESS (12.689s) [656.657482] [102/133] (368s left) kms_flip (flip-vs-suspend-interruptible) [656.749080] Starting subtest: flip-vs-suspend-interruptible [656.751501] Starting dynamic subtest: A-eDP1 [801.623985] Dynamic subtest A-eDP1: SUCCESS (11.361s) [801.626322] Subtest flip-vs-suspend-interruptible: SUCCESS (11.364s) [801.763036] [103/133] (223s left) i915_pm_rpm (gem-execbuf-stress-pc8) [803.303626] Starting subtest: gem-execbuf-stress-pc8 [803.340801] Subtest gem-execbuf-stress-pc8: SKIP (0.039s) [804.025422] [104/133] (221s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render) [804.116524] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render [804.121024] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [804.247493] [105/133] (221s left) kms_psr (psr-primary-mmap-cpu) [804.331920] Starting subtest: psr-primary-mmap-cpu [804.334281] Starting dynamic subtest: eDP-1 [806.110701] Dynamic subtest eDP-1: SUCCESS (1.771s) [806.113121] Subtest psr-primary-mmap-cpu: SUCCESS (1.772s) [806.987043] [106/133] (218s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt) [807.089856] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt [807.094329] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [807.201775] [107/133] (218s left) gem_close_race (basic-threads) [807.274871] Starting subtest: basic-threads [808.577136] Subtest basic-threads: SUCCESS (1.302s) [808.777409] [108/133] (216s left) gem_vm_create (create-ext) [808.831954] Starting subtest: create-ext [808.838082] Subtest create-ext: SUCCESS (0.006s) [808.962315] [109/133] (216s left) prime_vgem (coherency-gtt) [809.031658] Starting subtest: coherency-gtt [809.036631] Subtest coherency-gtt: SKIP (0.000s) [809.133754] [110/133] (216s left) kms_async_flips (async-flip-with-page-flip-events-linear-atomic) [809.228855] Starting subtest: async-flip-with-page-flip-events-linear-atomic [809.613146] Starting dynamic subtest: pipe-A-eDP-1 [812.368964] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.751s) [812.743513] Starting dynamic subtest: pipe-B-eDP-1 [815.508586] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.767s) [815.875423] Starting dynamic subtest: pipe-C-eDP-1 [818.648145] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.780s) [819.016091] Starting dynamic subtest: pipe-D-eDP-1 [821.783380] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.771s) [821.786101] Subtest async-flip-with-page-flip-events-linear-atomic: SUCCESS (12.537s) [822.971632] [111/133] (202s left) gem_mmap_gtt (big-copy) [823.033630] Subtest big-copy: SKIP (0.000s) [823.110052] [112/133] (202s left) kms_big_fb (yf-tiled-8bpp-rotate-270) [823.215426] Starting subtest: yf-tiled-8bpp-rotate-270 [823.219936] Subtest yf-tiled-8bpp-rotate-270: SKIP (0.000s) [823.303569] [113/133] (202s left) kms_chamelium_hpd (hdmi-hpd-enable-disable-mode) [823.679811] Subtest hdmi-hpd-enable-disable-mode: SKIP (0.000s) [824.468266] [114/133] (201s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite) [824.563787] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite [824.568567] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [824.668300] [115/133] (201s left) kms_chamelium_color (ctm-red-to-blue) [824.760202] Subtest ctm-red-to-blue: SKIP (0.000s) [824.811162] [116/133] (201s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt) [824.923821] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt [824.927924] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [825.019558] [117/133] (200s left) kms_dsc (dsc-fractional-bpp) [825.115862] Starting subtest: dsc-fractional-bpp [825.129021] Subtest dsc-fractional-bpp: SKIP (0.000s) [825.191467] [118/133] (200s left) gem_pxp (create-regular-context-1) [825.303654] Starting subtest: create-regular-context-1 [825.306361] Subtest create-regular-context-1: SUCCESS (0.002s) [825.422232] [119/133] (200s left) kms_atomic_transition (plane-primary-toggle-with-vblank-wait) [825.519871] Starting subtest: plane-primary-toggle-with-vblank-wait [825.521674] Starting dynamic subtest: pipe-A-eDP-1 [825.694135] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.174s) [826.003462] Starting dynamic subtest: pipe-B-eDP-1 [826.893300] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.899s) [827.194331] Subtest plane-primary-toggle-with-vblank-wait: SUCCESS (1.672s) [828.068313] [120/133] (197s left) gem_ctx_shared (create-shared-gtt) [828.136589] Starting subtest: create-shared-gtt [830.289847] Subtest create-shared-gtt: SUCCESS (2.151s) [830.984412] [121/133] (195s left) kms_psr (fbc-psr-cursor-blt) [831.080676] Starting subtest: fbc-psr-cursor-blt [831.082980] Starting dynamic subtest: eDP-1 [831.087033] Dynamic subtest eDP-1: SKIP (0.000s) [831.091059] Subtest fbc-psr-cursor-blt: SKIP (0.001s) [831.156133] [122/133] (194s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted) [831.222202] Starting subtest: etime-multi-wait-all-available-unsubmitted [831.332177] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.108s) [831.421130] [123/133] (194s left) gem_exec_balancer (invalid-balancer) [831.489392] Starting subtest: invalid-balancer [832.374551] Subtest invalid-balancer: SUCCESS (0.883s) [832.688729] [124/133] (193s left) kms_hdr (static-toggle-suspend) [832.785044] Starting subtest: static-toggle-suspend [832.791241] Subtest static-toggle-suspend: SKIP (0.000s) [832.862342] [125/133] (193s left) gem_exec_endless (dispatch) [832.932037] Starting subtest: dispatch [832.934398] Starting dynamic subtest: rcs0 [832.941627] Dynamic subtest rcs0: SUCCESS (0.005s) [832.955077] Starting dynamic subtest: bcs0 [832.959121] Dynamic subtest bcs0: SUCCESS (0.004s) [832.970460] Starting dynamic subtest: vcs0 [832.974450] Dynamic subtest vcs0: SUCCESS (0.004s) [832.985450] Starting dynamic subtest: vcs1 [832.989544] Dynamic subtest vcs1: SUCCESS (0.004s) [832.999238] Starting dynamic subtest: vecs0 [833.003217] Dynamic subtest vecs0: SUCCESS (0.005s) [833.013326] Starting dynamic subtest: ccs0 [833.017300] Dynamic subtest ccs0: SUCCESS (0.004s) [833.019129] Subtest dispatch: SUCCESS (0.031s) [834.135367] [126/133] (192s left) kms_setmode (basic) [834.196526] Starting subtest: basic [834.519658] Starting dynamic subtest: pipe-A-eDP-1 [838.074433] Dynamic subtest pipe-A-eDP-1: FAIL (3.438s) [838.304958] Starting dynamic subtest: pipe-B-eDP-1 [841.757667] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.455s) [842.071967] Subtest basic: FAIL (7.868s) [842.865172] [127/133] (183s left) perf (invalid-oa-format-id) [843.017792] Starting subtest: invalid-oa-format-id [843.028827] Subtest invalid-oa-format-id: SUCCESS (0.009s) [843.083490] [128/133] (183s left) kms_flip (basic-plain-flip) [843.183039] Starting subtest: basic-plain-flip [843.185190] Starting dynamic subtest: A-eDP1 [844.871336] Dynamic subtest A-eDP1: SUCCESS (1.686s) [844.887285] Starting dynamic subtest: B-eDP1 [846.514686] Dynamic subtest B-eDP1: SUCCESS (1.640s) [846.527567] Starting dynamic subtest: C-eDP1 [848.142118] Dynamic subtest C-eDP1: SUCCESS (1.624s) [848.155771] Starting dynamic subtest: D-eDP1 [849.771776] Dynamic subtest D-eDP1: SUCCESS (1.627s) [849.776995] Subtest basic-plain-flip: SUCCESS (6.590s) [850.959888] [129/133] (175s left) gem_ringfill (engines-basic) [857.074790] Starting subtest: engines-basic [857.077386] Starting dynamic subtest: rcs0 [857.134794] Dynamic subtest rcs0: SUCCESS (0.060s) [857.147850] Starting dynamic subtest: bcs0 [857.179614] Dynamic subtest bcs0: SUCCESS (0.043s) [857.190930] Starting dynamic subtest: vcs0 [857.221626] Dynamic subtest vcs0: SUCCESS (0.040s) [857.232878] Starting dynamic subtest: vcs1 [857.265447] Dynamic subtest vcs1: SUCCESS (0.042s) [857.276074] Starting dynamic subtest: vecs0 [857.307529] Dynamic subtest vecs0: SUCCESS (0.040s) [857.318484] Starting dynamic subtest: ccs0 [857.352530] Dynamic subtest ccs0: SUCCESS (0.043s) [857.354844] Subtest engines-basic: SUCCESS (0.280s) [857.445036] [130/133] (169s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [857.487792] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [857.561632] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.005s) [857.603769] [131/133] (168s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-pwrite) [857.716857] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-pwrite [865.283617] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-pwrite: SUCCESS (7.566s) [865.399943] [132/133] (161s left) api_intel_allocator (reloc-allocator) [865.466742] Starting subtest: reloc-allocator [865.469181] Starting dynamic subtest: basic [865.471566] Dynamic subtest basic: SUCCESS (0.003s) [865.487325] Starting dynamic subtest: parallel-one [865.489400] Dynamic subtest parallel-one: SUCCESS (0.008s) [865.499284] Starting dynamic subtest: print [865.501123] Dynamic subtest print: SUCCESS (0.000s) [865.510305] Starting dynamic subtest: reuse [865.512159] Dynamic subtest reuse: SUCCESS (0.000s) [865.521188] Starting dynamic subtest: fork-reopen-allocator [865.523090] Dynamic subtest fork-reopen-allocator: SUCCESS (0.012s) [865.524987] Subtest reloc-allocator: SUCCESS (0.027s) [865.632435] [133/133] (160s left) dmabuf_sync_file (import-basic) [865.684505] Starting subtest: import-basic [865.686878] Subtest import-basic: SUCCESS (0.002s) [865.739722] Closing watchdogs results: parsing output: 0/ for test: perf results: parsing output: 1/ for test: gem_ctx_param results: parsing output: 2/ for test: gem_exec_params results: parsing output: 3/ for test: kms_plane results: parsing output: 4/ for test: gem_exec_nop results: parsing output: 5/ for test: kms_vblank results: parsing output: 6/ for test: kms_busy results: parsing output: 7/ for test: i915_module_load results: parsing output: 8/ for test: kms_cursor_legacy results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_cursor_crc results: parsing output: 11/ for test: gem_exec_schedule results: parsing output: 12/ for test: kms_cursor_edge_walk results: parsing output: 13/ for test: gem_render_copy results: parsing output: 14/ for test: i915_drm_fdinfo results: parsing output: 15/ for test: kms_plane results: parsing output: 16/ for test: perf_pmu results: parsing output: 17/ for test: perf_pmu results: parsing output: 18/ for test: syncobj_wait results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_psr results: parsing output: 21/ for test: gem_mmap_gtt results: parsing output: 22/ for test: kms_flip results: parsing output: 23/ for test: kms_rotation_crc results: parsing output: 24/ for test: kms_cdclk results: parsing output: 25/ for test: kms_big_fb results: parsing output: 26/ for test: kms_frontbuffer_tracking results: parsing output: 27/ for test: gem_eio results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: kms_pm_rpm results: parsing output: 30/ for test: kms_plane_multiple results: parsing output: 31/ for test: kms_addfb_basic results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: kms_psr results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: gem_exec_alignment results: parsing output: 36/ for test: kms_flip_scaled_crc results: parsing output: 37/ for test: syncobj_timeline results: parsing output: 38/ for test: syncobj_timeline results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: kms_pipe_stress results: parsing output: 41/ for test: kms_lease results: parsing output: 42/ for test: perf_pmu results: parsing output: 43/ for test: kms_flip results: parsing output: 44/ for test: syncobj_wait results: parsing output: 45/ for test: kms_content_protection results: parsing output: 46/ for test: kms_ccs results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: kms_ccs results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: kms_big_fb results: parsing output: 51/ for test: gem_exec_fence results: parsing output: 52/ for test: kms_color results: parsing output: 53/ for test: gem_exec_reloc results: parsing output: 54/ for test: syncobj_wait results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: i915_suspend results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: gem_create results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: gem_exec_reloc results: parsing output: 62/ for test: gen3_render_tiledy_blits results: parsing output: 63/ for test: kms_plane_scaling results: parsing output: 64/ for test: kms_addfb_basic results: parsing output: 65/ for test: kms_frontbuffer_tracking results: parsing output: 66/ for test: gem_lmem_swapping results: parsing output: 67/ for test: gem_exec_whisper results: parsing output: 68/ for test: kms_ccs results: parsing output: 69/ for test: kms_atomic_interruptible results: parsing output: 70/ for test: kms_panel_fitting results: parsing output: 71/ for test: gem_create results: parsing output: 72/ for test: kms_big_fb results: parsing output: 73/ for test: kms_rotation_crc results: parsing output: 74/ for test: syncobj_wait results: parsing output: 75/ for test: kms_cursor_crc results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: fbdev results: parsing output: 78/ for test: gem_linear_blits results: parsing output: 79/ for test: sw_sync results: parsing output: 80/ for test: kms_prop_blob results: parsing output: 81/ for test: gem_exec_flush results: parsing output: 82/ for test: kms_pm_lpsp results: parsing output: 83/ for test: kms_psr results: parsing output: 84/ for test: kms_psr2_sf results: parsing output: 85/ for test: gem_exec_schedule results: parsing output: 86/ for test: syncobj_wait results: parsing output: 87/ for test: kms_flip results: parsing output: 88/ for test: gem_exec_fence results: parsing output: 89/ for test: gem_mmap_offset results: parsing output: 90/ for test: gem_softpin results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: syncobj_timeline results: parsing output: 94/ for test: kms_async_flips results: parsing output: 95/ for test: api_intel_bb results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: gen7_exec_parse results: parsing output: 98/ for test: gem_userptr_blits results: parsing output: 99/ for test: kms_universal_plane results: parsing output: 100/ for test: kms_psr2_sf results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: i915_pm_rpm results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: kms_psr results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: gem_close_race results: parsing output: 107/ for test: gem_vm_create results: parsing output: 108/ for test: prime_vgem results: parsing output: 109/ for test: kms_async_flips results: parsing output: 110/ for test: gem_mmap_gtt results: parsing output: 111/ for test: kms_big_fb results: parsing output: 112/ for test: kms_chamelium_hpd results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: kms_chamelium_color results: parsing output: 115/ for test: kms_frontbuffer_tracking results: parsing output: 116/ for test: kms_dsc results: parsing output: 117/ for test: gem_pxp results: parsing output: 118/ for test: kms_atomic_transition results: parsing output: 119/ for test: gem_ctx_shared results: parsing output: 120/ for test: kms_psr results: parsing output: 121/ for test: syncobj_timeline results: parsing output: 122/ for test: gem_exec_balancer results: parsing output: 123/ for test: kms_hdr results: parsing output: 124/ for test: gem_exec_endless results: parsing output: 125/ for test: kms_setmode results: parsing output: 126/ for test: perf results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: gem_ringfill results: parsing output: 129/ for test: sriov_basic results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: api_intel_allocator results: parsing output: 132/ for test: dmabuf_sync_file Done.