[56.363973] Initializing watchdogs [56.364034] /dev/watchdog0 [56.378897] [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.383251] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.385478] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.388845] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [56.539514] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [56.544278] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.001s) [56.662881] [002/131] (960s left) gem_exec_fence (submit3) [56.854918] Starting subtest: submit3 [56.859593] Subtest submit3: SKIP (0.000s) [59.009145] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [59.012543] [003/131] (957s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [59.111072] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [59.115157] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [59.259612] [004/131] (957s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [59.363814] Starting subtest: fbc-rgb101010-draw-mmap-wc [63.905518] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.553s) [65.043897] [005/131] (951s left) gem_exec_balancer (noheartbeat) [65.302570] Starting subtest: noheartbeat [65.307022] Subtest noheartbeat: SKIP (0.000s) [65.428212] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [65.527306] Subtest ctm-blue-to-red: SKIP (0.000s) [65.571433] [007/131] (951s left) gem_workarounds (suspend-resume) [65.642996] Starting subtest: suspend-resume [82.466563] Subtest suspend-resume: SUCCESS (5.990s) [92.638400] [008/131] (934s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [92.754151] Starting subtest: planes-downscale-factor-0-75-unity-scaling [92.756442] Starting dynamic subtest: pipe-A [92.819076] Dynamic subtest pipe-A: SUCCESS (0.065s) [92.827888] Starting dynamic subtest: pipe-B [93.952728] Dynamic subtest pipe-B: SUCCESS (1.138s) [93.963392] Starting dynamic subtest: pipe-C [95.048208] Dynamic subtest pipe-C: SUCCESS (1.107s) [95.068553] Starting dynamic subtest: pipe-D [96.178297] Dynamic subtest pipe-D: SUCCESS (1.140s) [96.180893] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.454s) [97.351366] [009/131] (929s left) gem_pxp (create-regular-buffer) [97.487430] Starting subtest: create-regular-buffer [97.489990] Subtest create-regular-buffer: SUCCESS (0.000s) [97.619147] [010/131] (929s left) gem_exec_params (rel-constants-invalid-rel-gen5) [97.678202] Starting subtest: rel-constants-invalid-rel-gen5 [97.680395] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [97.808404] [011/131] (929s left) gem_exec_nop (basic-series) [97.899444] Starting subtest: basic-series [113.770362] Subtest basic-series: SUCCESS (15.931s) [114.033751] [012/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [114.153810] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [114.157759] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [114.290050] [013/131] (913s left) kms_psr (fbc-psr-primary-page-flip) [114.386286] Starting subtest: fbc-psr-primary-page-flip [114.388587] Starting dynamic subtest: eDP-1 [114.392840] Dynamic subtest eDP-1: SKIP (0.000s) [114.396735] Subtest fbc-psr-primary-page-flip: SKIP (0.002s) [114.482729] [014/131] (912s left) i915_pm_rps (engine-order) [114.547770] Starting subtest: engine-order [121.013115] Subtest engine-order: SUCCESS (6.470s) [121.174519] [015/131] (906s left) gem_softpin (evict-active) [121.249475] Starting subtest: evict-active [121.260006] Subtest evict-active: SUCCESS (0.010s) [121.422075] [016/131] (906s left) syncobj_timeline (wait-delayed-signal) [121.474495] Starting subtest: wait-delayed-signal [121.578079] Subtest wait-delayed-signal: SUCCESS (0.103s) [121.696671] [017/131] (905s left) kms_panel_fitting (atomic-fastset) [121.798782] Starting subtest: atomic-fastset [121.801194] Starting dynamic subtest: pipe-A-eDP-1 [121.944575] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.146s) [121.956311] Starting dynamic subtest: pipe-B-eDP-1 [123.122508] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.178s) [123.132370] Starting dynamic subtest: pipe-C-eDP-1 [124.305362] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.181s) [124.315931] Starting dynamic subtest: pipe-D-eDP-1 [125.442592] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [125.444953] Subtest atomic-fastset: SUCCESS (3.643s) [126.612473] [018/131] (900s left) kms_big_fb (x-tiled-16bpp-rotate-270) [126.721591] Starting subtest: x-tiled-16bpp-rotate-270 [126.741158] Subtest x-tiled-16bpp-rotate-270: SKIP (0.019s) [126.906467] [019/131] (900s left) api_intel_bb (render-ccs) [126.976922] Starting subtest: render-ccs [127.349436] Subtest render-ccs: SUCCESS (0.371s) [127.504419] [020/131] (900s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [127.608521] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [127.610769] Starting dynamic subtest: pipe-A-eDP-1 [127.633357] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [127.644441] Starting dynamic subtest: pipe-B-eDP-1 [127.665788] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [127.674693] Starting dynamic subtest: pipe-C-eDP-1 [127.698212] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [127.708301] Starting dynamic subtest: pipe-D-eDP-1 [127.730469] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [127.734549] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [129.877803] [021/131] (897s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [129.942698] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [130.050309] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s) [130.154762] [022/131] (897s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [130.247870] Starting subtest: psr-2p-primscrn-cur-indfb-move [130.252153] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [130.349619] [023/131] (897s left) gem_lmem_swapping (heavy-multi) [130.393698] Subtest heavy-multi: SKIP (0.000s) [130.438068] [024/131] (897s left) kms_async_flips (test-cursor) [130.530062] Starting subtest: test-cursor [130.534536] Subtest test-cursor: SKIP (0.000s) [131.733321] [025/131] (896s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [136.782882] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [136.785262] Starting dynamic subtest: pipe-A-eDP-1 [137.583027] Dynamic subtest pipe-A-eDP-1: SKIP (0.798s) [137.593260] Starting dynamic subtest: pipe-B-eDP-1 [138.720122] Dynamic subtest pipe-B-eDP-1: SKIP (1.135s) [138.724186] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.936s) [139.935187] [026/131] (888s left) kms_plane_multiple (2x-tiling-4) [140.043041] Starting subtest: 2x-tiling-4 [140.047176] Subtest 2x-tiling-4: SKIP (0.000s) [140.143902] [027/131] (887s left) gem_ctx_param (invalid-param-set) [140.199333] Starting subtest: invalid-param-set [140.201511] Subtest invalid-param-set: SUCCESS (0.000s) [140.299214] [028/131] (887s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [140.390792] Starting subtest: bad-pixel-format-y-tiled-ccs [140.393123] Starting dynamic subtest: pipe-A-eDP-1 [140.414919] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [140.425810] Starting dynamic subtest: pipe-B-eDP-1 [140.445851] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [140.454957] Starting dynamic subtest: pipe-C-eDP-1 [140.475898] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [140.485746] Starting dynamic subtest: pipe-D-eDP-1 [140.507224] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [140.511231] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.004s) [142.612393] [029/131] (885s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [142.711633] Starting subtest: plane-downscale-factor-0-5-with-modifiers [142.714007] Starting dynamic subtest: pipe-A [142.731541] Dynamic subtest pipe-A: SKIP (0.017s) [142.744428] Starting dynamic subtest: pipe-B [142.761519] Dynamic subtest pipe-B: SKIP (0.030s) [142.772636] Starting dynamic subtest: pipe-C [142.794353] Dynamic subtest pipe-C: SKIP (0.031s) [142.803231] Starting dynamic subtest: pipe-D [142.825920] Dynamic subtest pipe-D: SKIP (0.031s) [142.830318] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.110s) [142.957060] [030/131] (885s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [143.013557] Starting subtest: multi-wait-all-available-submitted-signaled [143.015798] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [143.154864] [031/131] (885s left) perf (missing-sample-flags) [143.300816] Starting subtest: missing-sample-flags [143.303098] Subtest missing-sample-flags: SUCCESS (0.000s) [143.340583] [032/131] (884s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [143.440506] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [149.592439] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.154s) [150.740340] [033/131] (877s left) kms_pm_rpm (system-suspend-idle) [152.910971] Starting subtest: system-suspend-idle [173.017034] Subtest system-suspend-idle: SUCCESS (5.032s) [181.429727] [034/131] (854s left) kms_vblank (wait-forked) [181.530185] Starting subtest: wait-forked [181.532311] Starting dynamic subtest: pipe-A-eDP-1 [183.322946] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.811s) [183.337449] Starting dynamic subtest: pipe-D-eDP-1 [185.838401] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.535s) [185.840656] Subtest wait-forked: SUCCESS (4.349s) [186.724294] [035/131] (849s left) kms_big_fb (y-tiled-32bpp-rotate-0) [186.821638] Starting subtest: y-tiled-32bpp-rotate-0 [186.825886] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [186.956442] [036/131] (849s left) kms_pipe_crc_basic (read-crc) [187.040805] Starting subtest: read-crc [187.042969] Starting dynamic subtest: pipe-A-eDP-1 [187.747519] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s) [187.757858] Starting dynamic subtest: pipe-B-eDP-1 [189.156648] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.415s) [189.167077] Starting dynamic subtest: pipe-C-eDP-1 [190.537473] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.387s) [190.547385] Starting dynamic subtest: pipe-D-eDP-1 [191.866488] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.331s) [191.868715] Subtest read-crc: SUCCESS (4.847s) [192.718607] [037/131] (843s left) kms_cursor_legacy (single-move) [192.841427] Starting subtest: single-move [192.843298] Starting dynamic subtest: pipe-A [198.210657] Dynamic subtest pipe-A: SUCCESS (5.379s) [198.222587] Starting dynamic subtest: pipe-B [203.585608] Dynamic subtest pipe-B: SUCCESS (5.380s) [203.596922] Starting dynamic subtest: pipe-C [208.961079] Dynamic subtest pipe-C: SUCCESS (5.380s) [208.972027] Starting dynamic subtest: pipe-D [214.368209] Dynamic subtest pipe-D: SUCCESS (5.379s) [214.380055] Starting dynamic subtest: all-pipes [219.733419] Dynamic subtest all-pipes: SUCCESS (5.390s) [219.736230] Subtest single-move: SUCCESS (26.917s) [219.897308] [038/131] (816s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [224.931465] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [224.935983] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.002s) [225.821541] [039/131] (810s left) gem_unref_active_buffers [226.082298] [040/131] (810s left) kms_psr (fbc-psr2-primary-mmap-gtt) [226.184167] Starting subtest: fbc-psr2-primary-mmap-gtt [226.186419] Starting dynamic subtest: eDP-1 [226.190443] Dynamic subtest eDP-1: SKIP (0.000s) [226.194537] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [226.282032] [041/131] (810s left) syncobj_wait (invalid-signal-zero-handles) [226.336094] Starting subtest: invalid-signal-zero-handles [226.338393] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [226.452629] [042/131] (810s left) gen9_exec_parse (bb-oversize) [226.512421] Subtest bb-oversize: SKIP (0.000s) [226.591717] [043/131] (810s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [226.644088] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [226.753192] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.108s) [226.858609] [044/131] (809s left) gem_exec_reloc (basic-write-cpu-noreloc) [226.919429] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [227.000690] [045/131] (809s left) gem_mmap_offset (bad-flags) [227.059292] Starting subtest: bad-flags [227.061632] Subtest bad-flags: SUCCESS (0.000s) [227.184633] [046/131] (809s left) kms_cursor_legacy (cursor-vs-flip-legacy) [227.300818] Starting subtest: cursor-vs-flip-legacy [256.542771] Subtest cursor-vs-flip-legacy: SUCCESS (29.248s) [257.452101] [047/131] (779s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [257.572380] Starting subtest: sprite-rotation-90-pos-100-0 [257.576695] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [257.679904] [048/131] (779s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [257.798093] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [258.820760] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.024s) [258.977662] [049/131] (777s left) gem_create (busy-create) [259.047591] Starting subtest: busy-create [259.049960] Starting dynamic subtest: smem0 [292.837772] Dynamic subtest smem0: SUCCESS (33.788s) [292.840495] Subtest busy-create: SUCCESS (33.789s) [293.060701] [050/131] (743s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [293.171593] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [297.271704] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.102s) [298.461276] [051/131] (738s left) perf (invalid-open-flags) [298.568590] Starting subtest: invalid-open-flags [298.571104] Subtest invalid-open-flags: SUCCESS (0.000s) [298.614477] [052/131] (738s left) perf (oa-formats) [298.708346] Starting subtest: oa-formats [298.710771] Starting dynamic subtest: 0-rcs0 [298.724355] Dynamic subtest 0-rcs0: SUCCESS (0.015s) [298.736208] Starting dynamic subtest: 1-vcs0 [298.751038] Dynamic subtest 1-vcs0: SUCCESS (0.025s) [298.753247] Subtest oa-formats: SUCCESS (0.043s) [298.801502] [053/131] (738s left) kms_big_fb (4-tiled-8bpp-rotate-270) [298.907022] Starting subtest: 4-tiled-8bpp-rotate-270 [298.927951] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.020s) [299.106128] [054/131] (738s left) kms_cursor_crc (cursor-onscreen-64x21) [299.289640] Starting subtest: cursor-onscreen-64x21 [299.336546] Subtest cursor-onscreen-64x21: SKIP (0.042s) [299.579674] [055/131] (737s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [299.666494] Starting subtest: primary-4-tiled-reflect-x-180 [306.751840] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.084s) [308.029716] [056/131] (729s left) kms_cursor_crc (cursor-onscreen-256x256) [308.275414] Starting subtest: cursor-onscreen-256x256 [308.280308] Starting dynamic subtest: pipe-A-eDP-1 [310.410914] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.130s) [310.439446] Starting dynamic subtest: pipe-D-eDP-1 [313.161444] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.728s) [313.163302] Subtest cursor-onscreen-256x256: SUCCESS (4.886s) [313.977761] [057/131] (723s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [314.091791] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [321.507792] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.417s) [321.688790] [058/131] (715s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [321.797336] Starting subtest: async-flip-with-page-flip-events-tiled [322.179148] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [324.958394] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.779s) [324.968434] Starting dynamic subtest: pipe-A-eDP-1-4 [327.144144] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.185s) [327.153982] Starting dynamic subtest: pipe-A-eDP-1-4 [329.153597] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.008s) [329.169125] Starting dynamic subtest: pipe-A-eDP-1-x [331.344108] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.189s) [331.709626] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [334.481388] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.779s) [334.491416] Starting dynamic subtest: pipe-B-eDP-1-4 [336.666811] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.185s) [336.676546] Starting dynamic subtest: pipe-B-eDP-1-4 [338.677007] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [338.691935] Starting dynamic subtest: pipe-B-eDP-1-x [340.867302] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.190s) [341.244386] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [344.015070] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.778s) [344.025191] Starting dynamic subtest: pipe-C-eDP-1-4 [346.178872] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.163s) [346.190035] Starting dynamic subtest: pipe-C-eDP-1-4 [348.188438] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [348.198813] Starting dynamic subtest: pipe-C-eDP-1-x [350.378221] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.189s) [350.740979] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [353.541981] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.807s) [353.556664] Starting dynamic subtest: pipe-D-eDP-1-4 [355.716799] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.175s) [355.726502] Starting dynamic subtest: pipe-D-eDP-1-4 [357.725765] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s) [357.738296] Starting dynamic subtest: pipe-D-eDP-1-x [359.893175] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.167s) [359.895657] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.103s) [361.147497] [059/131] (676s left) perf (polling) [361.269365] Starting subtest: polling [361.271776] Starting dynamic subtest: 0-rcs0 [371.285170] Dynamic subtest 0-rcs0: SUCCESS (10.015s) [371.294950] Starting dynamic subtest: 1-vcs1 [381.304361] Dynamic subtest 1-vcs1: SUCCESS (10.021s) [381.306895] Subtest polling: SUCCESS (20.039s) [381.353146] [060/131] (656s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [381.448443] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [381.452618] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [381.591666] [061/131] (655s left) syncobj_timeline (reset-signaled) [381.650510] Starting subtest: reset-signaled [381.652790] Subtest reset-signaled: SUCCESS (0.000s) [381.792056] [062/131] (655s left) kms_rmfb (rmfb-ioctl) [381.881776] Starting subtest: rmfb-ioctl [381.883937] Starting dynamic subtest: pipe-A-eDP-1 [381.987122] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [381.998591] Starting dynamic subtest: pipe-B-eDP-1 [383.169559] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.180s) [383.182884] Starting dynamic subtest: pipe-C-eDP-1 [384.294825] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.122s) [384.304038] Starting dynamic subtest: pipe-D-eDP-1 [385.431064] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [385.433434] Subtest rmfb-ioctl: SUCCESS (3.553s) [386.661764] [063/131] (650s left) gem_userptr_blits (create-destroy-sync) [386.733420] Starting subtest: create-destroy-sync [391.744965] Subtest create-destroy-sync: SUCCESS (5.013s) [391.916333] [064/131] (645s left) gem_exec_reloc (basic-gtt-cpu-active) [391.985503] Subtest basic-gtt-cpu-active: SKIP (0.000s) [392.078559] [065/131] (645s left) api_intel_allocator (execbuf-with-allocator) [392.132032] Starting subtest: execbuf-with-allocator [392.139688] Subtest execbuf-with-allocator: SUCCESS (0.011s) [392.263634] [066/131] (645s left) kms_lease (cursor-implicit-plane) [392.366200] Starting subtest: cursor-implicit-plane [392.368517] Starting dynamic subtest: pipe-A-eDP-1 [392.828431] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.461s) [392.837597] Starting dynamic subtest: pipe-B-eDP-1 [393.957638] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.129s) [393.967328] Starting dynamic subtest: pipe-C-eDP-1 [395.067053] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.108s) [395.077406] Starting dynamic subtest: pipe-D-eDP-1 [396.210058] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.140s) [396.212218] Subtest cursor-implicit-plane: SUCCESS (3.844s) [397.087429] [067/131] (640s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [397.225885] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [397.230433] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [397.405453] [068/131] (640s left) syncobj_wait (invalid-signal-illegal-handle) [397.463406] Starting subtest: invalid-signal-illegal-handle [397.465598] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [397.607818] [069/131] (640s left) kms_psr (psr-primary-blt) [397.700956] Starting subtest: psr-primary-blt [397.703038] Starting dynamic subtest: eDP-1 [399.464485] Dynamic subtest eDP-1: SUCCESS (1.763s) [399.466769] Subtest psr-primary-blt: SUCCESS (1.764s) [400.335787] [070/131] (637s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [400.440246] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [400.442603] Starting dynamic subtest: pipe-A-eDP-1 [400.498765] Dynamic subtest pipe-A-eDP-1: SKIP (0.003s) [400.508668] Starting dynamic subtest: pipe-B-eDP-1 [400.563578] Dynamic subtest pipe-B-eDP-1: SKIP (0.003s) [400.573975] Starting dynamic subtest: pipe-C-eDP-1 [400.630415] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [400.640861] Starting dynamic subtest: pipe-D-eDP-1 [400.698115] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [400.702700] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.017s) [402.814376] [071/131] (635s left) kms_psr (pr-primary-blt) [402.910062] Starting subtest: pr-primary-blt [402.914617] Subtest pr-primary-blt: SKIP (0.000s) [403.008211] [072/131] (634s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [403.118538] Starting subtest: psr-2p-primscrn-spr-indfb-move [403.122667] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [403.245678] [073/131] (634s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [403.344112] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [403.346234] Starting dynamic subtest: pipe-A-default-mode [404.453700] Dynamic subtest pipe-A-default-mode: SKIP (1.106s) [404.457850] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.108s) [404.649544] [074/131] (633s left) gem_exec_schedule (u-semaphore-noskip) [404.726807] Starting subtest: u-semaphore-noskip [405.117437] Subtest u-semaphore-noskip: SUCCESS (0.397s) [405.487702] [075/131] (632s left) i915_drm_fdinfo (memory-info-idle) [405.529154] Starting subtest: memory-info-idle [405.531580] Starting dynamic subtest: smem0 [405.578844] Dynamic subtest smem0: SUCCESS (0.050s) [405.581297] Subtest memory-info-idle: SUCCESS (0.051s) [405.677416] [076/131] (632s left) i915_selftest (live) [407.632302] Starting subtest: live [407.634770] Starting dynamic subtest: sanitycheck [412.064450] Dynamic subtest sanitycheck: SUCCESS (4.430s) [412.074126] Starting dynamic subtest: uncore [416.512428] Dynamic subtest uncore: SUCCESS (4.445s) [416.522181] Starting dynamic subtest: workarounds [419.834503] Dynamic subtest workarounds: SUCCESS (3.319s) [419.844006] Starting dynamic subtest: gt_engines [424.551218] Dynamic subtest gt_engines: SUCCESS (4.712s) [424.561440] Starting dynamic subtest: gt_timelines [440.579456] Dynamic subtest gt_timelines: SUCCESS (16.021s) [440.594500] Starting dynamic subtest: gt_contexts [443.477194] Dynamic subtest gt_contexts: SUCCESS (2.895s) [443.487718] Starting dynamic subtest: gt_lrc [449.773711] Dynamic subtest gt_lrc: SUCCESS (6.293s) [449.783869] Starting dynamic subtest: gt_mocs [452.886605] Dynamic subtest gt_mocs: SUCCESS (3.110s) [452.902298] Starting dynamic subtest: gt_pm [457.793690] Dynamic subtest gt_pm: SUCCESS (4.904s) [457.803862] Starting dynamic subtest: gt_heartbeat [462.262430] Dynamic subtest gt_heartbeat: SUCCESS (4.466s) [462.272047] Starting dynamic subtest: gt_tlb [471.658113] Dynamic subtest gt_tlb: SUCCESS (9.392s) [471.668108] Starting dynamic subtest: requests [483.233202] Dynamic subtest requests: SUCCESS (11.573s) [483.243727] Starting dynamic subtest: migrate [491.434808] Dynamic subtest migrate: SUCCESS (8.200s) [491.444772] Starting dynamic subtest: active [495.903725] Dynamic subtest active: SUCCESS (4.467s) [495.919302] Starting dynamic subtest: objects [500.789903] Dynamic subtest objects: SUCCESS (4.884s) [500.799397] Starting dynamic subtest: mman [504.302712] Dynamic subtest mman: SUCCESS (3.511s) [504.312667] Starting dynamic subtest: dmabuf [507.171897] Dynamic subtest dmabuf: SUCCESS (2.867s) [507.182144] Starting dynamic subtest: vma [511.622675] Dynamic subtest vma: SUCCESS (4.449s) [511.632587] Starting dynamic subtest: coherency [517.236738] Dynamic subtest coherency: SUCCESS (5.612s) [517.246603] Starting dynamic subtest: gtt [529.276932] Dynamic subtest gtt: SUCCESS (12.040s) [529.287123] Starting dynamic subtest: gem [537.654160] Dynamic subtest gem: SUCCESS (8.376s) [537.663385] Starting dynamic subtest: evict [543.234634] Dynamic subtest evict: SUCCESS (5.579s) [543.243314] Starting dynamic subtest: hugepages [554.377797] Dynamic subtest hugepages: SUCCESS (11.142s) [554.387876] Starting dynamic subtest: gem_contexts [582.887107] Dynamic subtest gem_contexts: SUCCESS (28.510s) [582.897274] Starting dynamic subtest: client [587.377745] Dynamic subtest client: SUCCESS (4.491s) [587.392781] Starting dynamic subtest: gem_migrate [591.879415] Dynamic subtest gem_migrate: SUCCESS (4.500s) [591.889442] Starting dynamic subtest: reset [594.785362] Dynamic subtest reset: SUCCESS (2.904s) [594.795943] Starting dynamic subtest: memory_region [599.266828] Dynamic subtest memory_region: SUCCESS (4.480s) [599.277130] Starting dynamic subtest: hangcheck [614.464410] Dynamic subtest hangcheck: SUCCESS (15.197s) [614.474460] Starting dynamic subtest: execlists [618.941729] Dynamic subtest execlists: SUCCESS (4.477s) [618.951361] Starting dynamic subtest: ring_submission [623.401441] Dynamic subtest ring_submission: SUCCESS (4.458s) [623.416608] Starting dynamic subtest: perf [627.821719] Dynamic subtest perf: SUCCESS (4.419s) [627.831569] Starting dynamic subtest: slpc [642.011587] Dynamic subtest slpc: SUCCESS (14.190s) [642.021556] Starting dynamic subtest: guc [646.058008] Dynamic subtest guc: SUCCESS (4.045s) [646.067999] Starting dynamic subtest: guc_multi_lrc [650.509594] Dynamic subtest guc_multi_lrc: SUCCESS (4.450s) [650.519153] Starting dynamic subtest: guc_hang [655.512730] Dynamic subtest guc_hang: SUCCESS (5.001s) [655.522971] Starting dynamic subtest: late_gt_pm [659.963879] Dynamic subtest late_gt_pm: SUCCESS (4.450s) [659.966485] Subtest live: SUCCESS (252.338s) [659.999104] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [659.999801] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [660.002888] [077/131] (378s left) gem_userptr_blits (nohangcheck) [661.575065] Starting subtest: nohangcheck [661.825201] Subtest nohangcheck: SUCCESS (0.247s) [661.901476] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [661.902988] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [661.906787] [078/131] (376s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [662.010412] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [662.012581] Starting dynamic subtest: pipe-A-eDP-1 [662.889470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.873s) [662.902572] Starting dynamic subtest: pipe-B-eDP-1 [664.456542] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.562s) [664.467081] Starting dynamic subtest: pipe-C-eDP-1 [666.011837] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.553s) [666.023262] Starting dynamic subtest: pipe-D-eDP-1 [667.530137] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.514s) [667.532227] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.508s) [668.758051] [079/131] (369s left) gem_softpin (allocator-nopin) [668.825875] Starting subtest: allocator-nopin [668.923255] Subtest allocator-nopin: SUCCESS (0.097s) [669.077216] [080/131] (369s left) kms_draw_crc (draw-method-pwrite) [669.170903] Starting subtest: draw-method-pwrite [669.172992] Starting dynamic subtest: xrgb8888-untiled [669.769872] Dynamic subtest xrgb8888-untiled: SUCCESS (0.600s) [669.779739] Starting dynamic subtest: rgb565-untiled [670.225995] Dynamic subtest rgb565-untiled: SUCCESS (0.455s) [670.235349] Starting dynamic subtest: xrgb2101010-untiled [670.771298] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.542s) [670.780576] Starting dynamic subtest: xbgr16161616f-untiled [671.526690] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.755s) [671.536508] Starting dynamic subtest: xrgb8888-xtiled [673.283538] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.755s) [673.293202] Starting dynamic subtest: rgb565-xtiled [674.350784] Dynamic subtest rgb565-xtiled: SUCCESS (1.065s) [674.360132] Starting dynamic subtest: xrgb2101010-xtiled [676.174448] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.822s) [676.191387] Starting dynamic subtest: xbgr16161616f-xtiled [679.409749] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.232s) [679.426972] Starting dynamic subtest: xrgb8888-4tiled [680.510322] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.099s) [680.521009] Starting dynamic subtest: rgb565-4tiled [681.088180] Dynamic subtest rgb565-4tiled: SUCCESS (0.577s) [681.097624] Starting dynamic subtest: xrgb2101010-4tiled [682.200773] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.110s) [682.212857] Starting dynamic subtest: xbgr16161616f-4tiled [685.124096] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.921s) [685.126321] Subtest draw-method-pwrite: SUCCESS (15.945s) [685.256825] [081/131] (353s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [685.368398] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [685.372939] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [685.502618] [082/131] (352s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [685.604659] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [685.608979] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [685.726183] [083/131] (352s left) syncobj_timeline (host-signal-points) [685.784740] Starting subtest: host-signal-points [685.790076] Subtest host-signal-points: SUCCESS (0.004s) [685.928611] [084/131] (352s left) gem_mmap_gtt (basic-small-bo) [685.983900] Subtest basic-small-bo: SKIP (0.000s) [686.054691] [085/131] (352s left) perf_pmu (semaphore-wait-idle) [686.089122] Starting subtest: semaphore-wait-idle [686.091080] Starting dynamic subtest: rcs0 [686.605731] Dynamic subtest rcs0: SUCCESS (0.514s) [686.617430] Starting dynamic subtest: bcs0 [687.119039] Dynamic subtest bcs0: SUCCESS (0.510s) [687.129430] Starting dynamic subtest: vcs0 [687.631894] Dynamic subtest vcs0: SUCCESS (0.510s) [687.642400] Starting dynamic subtest: vcs1 [688.144151] Dynamic subtest vcs1: SUCCESS (0.510s) [688.156441] Starting dynamic subtest: vecs0 [688.660353] Dynamic subtest vecs0: SUCCESS (0.512s) [688.672714] Starting dynamic subtest: ccs0 [689.176778] Dynamic subtest ccs0: SUCCESS (0.513s) [689.179506] Subtest semaphore-wait-idle: SUCCESS (3.087s) [689.320746] [086/131] (349s left) kms_addfb_basic (no-handle) [689.375466] Starting subtest: no-handle [689.377679] Subtest no-handle: SUCCESS (0.000s) [689.543810] [087/131] (348s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [689.647881] Starting subtest: fbcpsr-rgb101010-draw-pwrite [696.631357] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (6.984s) [696.804482] [088/131] (341s left) gem_render_copy (yf-tiled-ccs-to-linear) [696.883580] Starting subtest: yf-tiled-ccs-to-linear [696.888114] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [697.089742] [089/131] (341s left) kms_flip (wf_vblank-ts-check) [697.190744] Starting subtest: wf_vblank-ts-check [697.193081] Starting dynamic subtest: A-eDP1 [706.094229] Dynamic subtest A-eDP1: SUCCESS (8.901s) [706.106236] Starting dynamic subtest: B-eDP1 [715.029883] Dynamic subtest B-eDP1: SUCCESS (8.931s) [715.039743] Starting dynamic subtest: C-eDP1 [723.955053] Dynamic subtest C-eDP1: SUCCESS (8.921s) [723.965701] Starting dynamic subtest: D-eDP1 [732.890886] Dynamic subtest D-eDP1: SUCCESS (8.932s) [732.893389] Subtest wf_vblank-ts-check: SUCCESS (35.693s) [734.134740] [090/131] (304s left) gem_exec_schedule (deep) [734.308716] Starting subtest: deep [734.311254] Starting dynamic subtest: rcs0 [739.132760] Dynamic subtest rcs0: SKIP (4.819s) [739.145103] Starting dynamic subtest: vcs0 [749.185814] Dynamic subtest vcs0: SUCCESS (10.053s) [749.196127] Starting dynamic subtest: vcs1 [760.648157] Dynamic subtest vcs1: SUCCESS (11.459s) [760.660282] Starting dynamic subtest: vecs0 [771.285779] Dynamic subtest vecs0: SUCCESS (10.636s) [771.299756] Starting dynamic subtest: ccs0 [783.223438] Dynamic subtest ccs0: SUCCESS (11.935s) [783.225859] Subtest deep: SUCCESS (48.908s) [784.515750] [091/131] (254s left) kms_sequence (queue-idle) [784.622278] Starting subtest: queue-idle [784.624496] Starting dynamic subtest: pipe-A-eDP-1 [786.425887] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.802s) [786.435931] Starting dynamic subtest: pipe-B-eDP-1 [788.867707] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.443s) [788.877488] Starting dynamic subtest: pipe-C-eDP-1 [791.293271] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.424s) [791.303990] Starting dynamic subtest: pipe-D-eDP-1 [793.721464] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.425s) [793.723801] Subtest queue-idle: SUCCESS (9.099s) [794.556977] [092/131] (244s left) gem_gtt_cpu_tlb [794.674748] [093/131] (244s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [794.775682] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [801.305738] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.532s) [801.468285] [094/131] (237s left) gem_eio (create-ext) [801.707804] Starting subtest: create-ext [802.040144] Subtest create-ext: SUCCESS (0.331s) [802.221259] [095/131] (236s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [802.280689] Subtest writes-after-reads-uncached: SKIP (0.000s) [802.369994] [096/131] (236s left) sysfs_preempt_timeout (idempotent) [802.434486] Starting subtest: idempotent [802.436467] Starting dynamic subtest: vecs0 [802.438347] Dynamic subtest vecs0: SUCCESS (0.000s) [802.449419] Starting dynamic subtest: ccs0 [802.451152] Dynamic subtest ccs0: SUCCESS (0.000s) [802.460405] Starting dynamic subtest: vcs0 [802.462204] Dynamic subtest vcs0: SUCCESS (0.000s) [802.471209] Starting dynamic subtest: bcs0 [802.472973] Dynamic subtest bcs0: SUCCESS (0.000s) [802.481673] Starting dynamic subtest: rcs0 [802.483439] Dynamic subtest rcs0: SUCCESS (0.000s) [802.492198] Starting dynamic subtest: vcs1 [802.494033] Dynamic subtest vcs1: SUCCESS (0.000s) [802.495899] Subtest idempotent: SUCCESS (0.006s) [802.574674] [097/131] (236s left) gem_busy (semaphore) [802.767961] Subtest semaphore: SKIP (0.000s) [803.025967] [098/131] (235s left) sriov_basic (enable-vfs-bind-unbind-each) [803.093040] Starting subtest: enable-vfs-bind-unbind-each [803.095474] Starting dynamic subtest: numvfs-1 [803.173603] Dynamic subtest numvfs-1: FAIL (0.031s) [803.184525] Starting dynamic subtest: numvfs-2 [803.252533] Dynamic subtest numvfs-2: FAIL (0.004s) [803.263312] Starting dynamic subtest: numvfs-3 [803.334416] Dynamic subtest numvfs-3: FAIL (0.004s) [803.345548] Starting dynamic subtest: numvfs-4 [803.417009] Dynamic subtest numvfs-4: FAIL (0.003s) [803.427648] Starting dynamic subtest: numvfs-5 [803.499209] Dynamic subtest numvfs-5: FAIL (0.004s) [803.510790] Starting dynamic subtest: numvfs-6 [803.582954] Dynamic subtest numvfs-6: FAIL (0.004s) [803.593630] Starting dynamic subtest: numvfs-7 [803.665421] Dynamic subtest numvfs-7: FAIL (0.004s) [803.676965] Starting dynamic subtest: numvfs-random [803.747993] Dynamic subtest numvfs-random: FAIL (0.004s) [803.750535] Subtest enable-vfs-bind-unbind-each: FAIL (0.062s) [803.790404] [099/131] (235s left) kms_pm_lpsp (screens-disabled) [804.897219] Starting subtest: screens-disabled [804.901193] Subtest screens-disabled: SKIP (0.000s) [804.996795] [100/131] (234s left) gem_exec_capture (capture-invisible) [805.053359] Starting subtest: capture-invisible [805.055675] Starting dynamic subtest: smem0 [805.059955] Dynamic subtest smem0: SKIP (0.000s) [805.064233] Subtest capture-invisible: SKIP (0.001s) [805.199114] [101/131] (233s left) gem_lmem_swapping (verify-ccs) [805.243999] Subtest verify-ccs: SKIP (0.000s) [805.281288] [102/131] (233s left) kms_joiner (basic-force-ultra-joiner) [805.391324] Starting subtest: basic-force-ultra-joiner [805.395230] Subtest basic-force-ultra-joiner: SKIP (0.000s) [805.480373] [103/131] (233s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [805.579977] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [812.032667] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.456s) [812.183799] [104/131] (227s left) kms_color (legacy-gamma) [812.285831] Starting subtest: legacy-gamma [812.287947] Starting dynamic subtest: pipe-A-eDP-1 [813.006290] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.720s) [813.016920] Starting dynamic subtest: pipe-B-eDP-1 [814.381399] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s) [814.391704] Starting dynamic subtest: pipe-C-eDP-1 [815.755397] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.374s) [815.766984] Starting dynamic subtest: pipe-D-eDP-1 [817.093454] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.338s) [817.096013] Subtest legacy-gamma: SUCCESS (4.809s) [817.976739] [105/131] (221s left) gem_exec_schedule (wide) [818.169161] Starting subtest: wide [818.171778] Starting dynamic subtest: rcs0 [828.601257] Dynamic subtest rcs0: SUCCESS (10.431s) [828.614593] Starting dynamic subtest: vcs0 [837.990124] Dynamic subtest vcs0: SUCCESS (9.389s) [838.002360] Starting dynamic subtest: vcs1 [849.383948] Dynamic subtest vcs1: SUCCESS (11.392s) [849.396075] Starting dynamic subtest: vecs0 [859.719460] Dynamic subtest vecs0: SUCCESS (10.336s) [859.740223] Starting dynamic subtest: ccs0 [874.205529] Dynamic subtest ccs0: SUCCESS (14.485s) [874.208820] Subtest wide: SUCCESS (56.039s) [876.426096] [106/131] (162s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [876.532211] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [876.534514] Starting dynamic subtest: pipe-A-default-mode [876.830807] Dynamic subtest pipe-A-default-mode: SKIP (0.298s) [876.835465] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.300s) [877.661329] [107/131] (161s left) kms_big_fb (linear-64bpp-rotate-180) [877.767191] Starting subtest: linear-64bpp-rotate-180 [879.387576] Subtest linear-64bpp-rotate-180: SUCCESS (1.622s) [879.593478] [108/131] (159s left) gem_ppgtt (blt-vs-render-ctxn) [879.661467] Starting subtest: blt-vs-render-ctxN [912.741552] Subtest blt-vs-render-ctxN: SUCCESS (33.079s) [912.915316] [109/131] (126s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [913.067205] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [913.071690] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [913.186731] [110/131] (126s left) kms_chamelium_frames (dp-frame-dump) [913.572511] Subtest dp-frame-dump: SKIP (0.000s) [914.340452] [111/131] (125s left) kms_psr2_su (page_flip-nv12) [914.404177] Subtest page_flip-NV12: SKIP (0.000s) [914.468731] [112/131] (125s left) gem_tiling_max_stride [914.601644] [113/131] (125s left) perf_pmu (busy-idle) [914.641956] Starting subtest: busy-idle [914.644232] Starting dynamic subtest: rcs0 [915.357272] Dynamic subtest rcs0: SUCCESS (0.714s) [915.370361] Starting dynamic subtest: bcs0 [916.015747] Dynamic subtest bcs0: SUCCESS (0.657s) [916.028765] Starting dynamic subtest: vcs0 [917.837163] Dynamic subtest vcs0: SUCCESS (1.818s) [917.850441] Starting dynamic subtest: vcs1 [919.820209] Dynamic subtest vcs1: SUCCESS (1.981s) [919.833600] Starting dynamic subtest: vecs0 [921.804911] Dynamic subtest vecs0: SUCCESS (1.982s) [921.818329] Starting dynamic subtest: ccs0 [922.477425] Dynamic subtest ccs0: SUCCESS (0.671s) [922.480129] Subtest busy-idle: SUCCESS (7.836s) [922.625937] [114/131] (117s left) dmabuf_sync_file (export-before-signal) [922.686709] Starting subtest: export-before-signal [922.688935] Subtest export-before-signal: SUCCESS (0.001s) [922.773392] [115/131] (117s left) gem_exec_reloc (basic-cpu-read) [922.822472] Subtest basic-cpu-read: SKIP (0.000s) [922.920185] [116/131] (116s left) kms_hdr (bpc-switch) [923.029174] Starting subtest: bpc-switch [924.138456] Starting dynamic subtest: pipe-A-eDP-1 [927.631701] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.491s) [927.634065] Subtest bpc-switch: SUCCESS (4.603s) [927.767139] [117/131] (112s left) perf (i915-ref-count) [927.884008] Starting subtest: i915-ref-count [927.953894] Subtest i915-ref-count: SUCCESS (0.068s) [928.012464] [118/131] (111s left) gem_ctx_isolation (nonpriv) [928.079338] Starting subtest: nonpriv [928.081278] Starting dynamic subtest: rcs0 [928.330066] Dynamic subtest rcs0: SUCCESS (0.252s) [928.343132] Starting dynamic subtest: bcs0 [928.590156] Dynamic subtest bcs0: SUCCESS (0.260s) [928.603646] Starting dynamic subtest: vcs0 [928.868750] Dynamic subtest vcs0: SUCCESS (0.278s) [928.881420] Starting dynamic subtest: vcs1 [930.044757] Dynamic subtest vcs1: SUCCESS (1.174s) [930.058032] Starting dynamic subtest: vecs0 [932.119993] Dynamic subtest vecs0: SUCCESS (2.074s) [932.132406] Starting dynamic subtest: ccs0 [934.138014] Dynamic subtest ccs0: SUCCESS (2.017s) [934.140412] Subtest nonpriv: SUCCESS (6.060s) [934.416988] [119/131] (105s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [934.497008] Starting subtest: y-tiled-to-vebox-x-tiled [934.501851] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [934.709434] [120/131] (105s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [934.815339] Starting subtest: plane-use-after-nonblocking-unbind [934.817609] Starting dynamic subtest: pipe-A-eDP-1 [934.880203] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.066s) [935.192148] Starting dynamic subtest: pipe-B-eDP-1 [935.990916] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.810s) [936.297960] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.483s) [937.172288] [121/131] (102s left) i915_hangman (engine-error-state-capture) [937.260637] Starting subtest: engine-error-state-capture [937.263208] Starting dynamic subtest: rcs0 [940.779358] Dynamic subtest rcs0: SUCCESS (3.518s) [940.792628] Starting dynamic subtest: bcs0 [946.795421] Dynamic subtest bcs0: SUCCESS (6.012s) [946.808910] Starting dynamic subtest: vcs0 [952.747419] Dynamic subtest vcs0: SUCCESS (5.948s) [952.760757] Starting dynamic subtest: vcs1 [957.803452] Dynamic subtest vcs1: SUCCESS (5.052s) [957.817077] Starting dynamic subtest: vecs0 [963.819208] Dynamic subtest vecs0: SUCCESS (6.012s) [963.832689] Starting dynamic subtest: ccs0 [969.771308] Dynamic subtest ccs0: SUCCESS (5.948s) [969.774068] Subtest engine-error-state-capture: SUCCESS (32.507s) [969.876952] [122/131] ( 70s left) gem_exec_schedule (pi-shared-iova) [970.067881] Starting subtest: pi-shared-iova [970.070032] Starting dynamic subtest: rcs0 [970.203106] Dynamic subtest rcs0: SUCCESS (0.137s) [970.217778] Starting dynamic subtest: vcs0 [970.285648] Dynamic subtest vcs0: SUCCESS (0.083s) [970.300174] Starting dynamic subtest: vcs1 [970.379179] Dynamic subtest vcs1: SUCCESS (0.093s) [970.394247] Starting dynamic subtest: vecs0 [970.462463] Dynamic subtest vecs0: SUCCESS (0.082s) [970.475810] Starting dynamic subtest: ccs0 [970.583600] Dynamic subtest ccs0: SUCCESS (0.120s) [970.586215] Subtest pi-shared-iova: SUCCESS (0.519s) [972.006428] [123/131] ( 68s left) syncobj_wait (invalid-reset-illegal-handle) [972.073207] Starting subtest: invalid-reset-illegal-handle [972.075536] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [972.214984] [124/131] ( 67s left) syncobj_wait (single-wait-all-for-submit-signaled) [972.273429] Starting subtest: single-wait-all-for-submit-signaled [972.275592] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [972.411978] [125/131] ( 67s left) kms_cursor_crc (cursor-sliding-512x170) [972.727386] Starting subtest: cursor-sliding-512x170 [972.731264] Subtest cursor-sliding-512x170: SKIP (0.001s) [972.915745] [126/131] ( 67s left) kms_chamelium_hpd (hdmi-hpd-fast) [973.314240] Subtest hdmi-hpd-fast: SKIP (0.000s) [974.156279] [127/131] ( 66s left) gem_ctx_persistence (hostile) [974.230864] Starting subtest: hostile [984.392302] Subtest hostile: SUCCESS (10.155s) [984.527798] [128/131] ( 55s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [984.622601] Starting subtest: fbc-rgb565-draw-blt [988.781160] Subtest fbc-rgb565-draw-blt: SUCCESS (4.161s) [990.010946] [129/131] ( 50s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [990.111969] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [999.355696] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.245s) [999.522288] [130/131] ( 40s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [999.620866] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [999.625106] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [999.756220] [131/131] ( 40s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [999.857927] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [999.862442] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [999.986445] Closing watchdogs results: parsing output: 0/ for test: kms_big_fb results: parsing output: 1/ for test: gem_exec_fence results: parsing output: 2/ for test: kms_frontbuffer_tracking results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: gem_exec_balancer results: parsing output: 5/ for test: kms_chamelium_color results: parsing output: 6/ for test: gem_workarounds results: parsing output: 7/ for test: kms_plane_scaling results: parsing output: 8/ for test: gem_pxp results: parsing output: 9/ for test: gem_exec_params results: parsing output: 10/ for test: gem_exec_nop results: parsing output: 11/ for test: kms_frontbuffer_tracking results: parsing output: 12/ for test: kms_psr results: parsing output: 13/ for test: i915_pm_rps results: parsing output: 14/ for test: gem_softpin results: parsing output: 15/ for test: syncobj_timeline results: parsing output: 16/ for test: kms_panel_fitting results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: api_intel_bb results: parsing output: 19/ for test: kms_ccs results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: gem_lmem_swapping results: parsing output: 23/ for test: kms_async_flips results: parsing output: 24/ for test: kms_psr2_sf results: parsing output: 25/ for test: kms_plane_multiple results: parsing output: 26/ for test: gem_ctx_param results: parsing output: 27/ for test: kms_ccs results: parsing output: 28/ for test: kms_plane_scaling results: parsing output: 29/ for test: syncobj_timeline results: parsing output: 30/ for test: perf results: parsing output: 31/ for test: kms_frontbuffer_tracking results: parsing output: 32/ for test: kms_pm_rpm results: parsing output: 33/ for test: kms_vblank results: parsing output: 34/ for test: kms_big_fb results: parsing output: 35/ for test: kms_pipe_crc_basic results: parsing output: 36/ for test: kms_cursor_legacy results: parsing output: 37/ for test: kms_psr2_sf results: parsing output: 38/ for test: gem_unref_active_buffers results: parsing output: 39/ for test: kms_psr results: parsing output: 40/ for test: syncobj_wait results: parsing output: 41/ for test: gen9_exec_parse results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: gem_exec_reloc results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_cursor_legacy results: parsing output: 46/ for test: kms_rotation_crc results: parsing output: 47/ for test: kms_big_fb results: parsing output: 48/ for test: gem_create results: parsing output: 49/ for test: kms_frontbuffer_tracking results: parsing output: 50/ for test: perf results: parsing output: 51/ for test: perf results: parsing output: 52/ for test: kms_big_fb results: parsing output: 53/ for test: kms_cursor_crc results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: kms_cursor_crc results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_async_flips results: parsing output: 58/ for test: perf results: parsing output: 59/ for test: kms_frontbuffer_tracking results: parsing output: 60/ for test: syncobj_timeline results: parsing output: 61/ for test: kms_rmfb results: parsing output: 62/ for test: gem_userptr_blits results: parsing output: 63/ for test: gem_exec_reloc results: parsing output: 64/ for test: api_intel_allocator results: parsing output: 65/ for test: kms_lease results: parsing output: 66/ for test: kms_cursor_legacy results: parsing output: 67/ for test: syncobj_wait results: parsing output: 68/ for test: kms_psr results: parsing output: 69/ for test: kms_ccs results: parsing output: 70/ for test: kms_psr results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_flip_scaled_crc results: parsing output: 73/ for test: gem_exec_schedule results: parsing output: 74/ for test: i915_drm_fdinfo results: parsing output: 75/ for test: i915_selftest results: parsing output: 76/ for test: gem_userptr_blits results: parsing output: 77/ for test: kms_ccs results: parsing output: 78/ for test: gem_softpin results: parsing output: 79/ for test: kms_draw_crc results: parsing output: 80/ for test: kms_big_fb results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: syncobj_timeline results: parsing output: 83/ for test: gem_mmap_gtt results: parsing output: 84/ for test: perf_pmu results: parsing output: 85/ for test: kms_addfb_basic results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: gem_render_copy results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gem_exec_schedule results: parsing output: 90/ for test: kms_sequence results: parsing output: 91/ for test: gem_gtt_cpu_tlb results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: gem_eio results: parsing output: 94/ for test: gem_partial_pwrite_pread results: parsing output: 95/ for test: sysfs_preempt_timeout results: parsing output: 96/ for test: gem_busy results: parsing output: 97/ for test: sriov_basic results: parsing output: 98/ for test: kms_pm_lpsp results: parsing output: 99/ for test: gem_exec_capture results: parsing output: 100/ for test: gem_lmem_swapping results: parsing output: 101/ for test: kms_joiner results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: kms_color results: parsing output: 104/ for test: gem_exec_schedule results: parsing output: 105/ for test: kms_flip_scaled_crc results: parsing output: 106/ for test: kms_big_fb results: parsing output: 107/ for test: gem_ppgtt results: parsing output: 108/ for test: kms_frontbuffer_tracking results: parsing output: 109/ for test: kms_chamelium_frames results: parsing output: 110/ for test: kms_psr2_su results: parsing output: 111/ for test: gem_tiling_max_stride results: parsing output: 112/ for test: perf_pmu results: parsing output: 113/ for test: dmabuf_sync_file results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: kms_hdr results: parsing output: 116/ for test: perf results: parsing output: 117/ for test: gem_ctx_isolation results: parsing output: 118/ for test: gem_render_copy results: parsing output: 119/ for test: kms_atomic_transition results: parsing output: 120/ for test: i915_hangman results: parsing output: 121/ for test: gem_exec_schedule results: parsing output: 122/ for test: syncobj_wait results: parsing output: 123/ for test: syncobj_wait results: parsing output: 124/ for test: kms_cursor_crc results: parsing output: 125/ for test: kms_chamelium_hpd results: parsing output: 126/ for test: gem_ctx_persistence results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_frontbuffer_tracking results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_frontbuffer_tracking Done.