[59.037035] Initializing watchdogs [59.037082] /dev/watchdog0 [59.054147] [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.058222] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.060394] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.063671] [001/131] (960s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip) [59.196927] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip [59.201409] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SKIP (0.000s) [59.305228] [002/131] (960s left) gem_exec_fence (submit3) [59.491875] Starting subtest: submit3 [59.496800] Subtest submit3: SKIP (0.000s) [61.018386] [FACT gem_exec_fence (submit3)] new: kernel.kmod_is_loaded.vgem: true [61.021253] [003/131] (958s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt) [61.127048] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt [61.131495] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [61.268822] [004/131] (958s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-mmap-wc) [61.361429] Starting subtest: fbc-rgb101010-draw-mmap-wc [65.968724] Subtest fbc-rgb101010-draw-mmap-wc: SUCCESS (4.609s) [67.154776] [005/131] (952s left) gem_exec_balancer (noheartbeat) [67.576381] Starting subtest: noheartbeat [67.581436] Subtest noheartbeat: SKIP (0.000s) [67.796654] [006/131] (951s left) kms_chamelium_color (ctm-blue-to-red) [67.932218] Subtest ctm-blue-to-red: SKIP (0.000s) [68.075471] [007/131] (951s left) gem_workarounds (suspend-resume) [68.150682] Starting subtest: suspend-resume [84.632978] Subtest suspend-resume: SUCCESS (4.843s) [84.787442] [008/131] (935s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling) [84.902512] Starting subtest: planes-downscale-factor-0-75-unity-scaling [84.904784] Starting dynamic subtest: pipe-A [84.967244] Dynamic subtest pipe-A: SUCCESS (0.065s) [84.975946] Starting dynamic subtest: pipe-B [86.107511] Dynamic subtest pipe-B: SUCCESS (1.138s) [86.117865] Starting dynamic subtest: pipe-C [87.227299] Dynamic subtest pipe-C: SUCCESS (1.118s) [87.236578] Starting dynamic subtest: pipe-D [88.354923] Dynamic subtest pipe-D: SUCCESS (1.126s) [88.357377] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (3.451s) [89.559570] [009/131] (930s left) gem_pxp (create-regular-buffer) [89.677119] Starting subtest: create-regular-buffer [89.679506] Subtest create-regular-buffer: SUCCESS (0.000s) [89.806280] [010/131] (930s left) gem_exec_params (rel-constants-invalid-rel-gen5) [89.866274] Starting subtest: rel-constants-invalid-rel-gen5 [89.868314] Subtest rel-constants-invalid-rel-gen5: SUCCESS (0.000s) [89.984571] [011/131] (930s left) gem_exec_nop (basic-series) [90.052019] Starting subtest: basic-series [106.575940] Subtest basic-series: SUCCESS (16.529s) [106.827155] [012/131] (913s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-wc) [106.929035] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-wc [106.933314] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [107.096081] [013/131] (913s left) kms_psr (fbc-psr-primary-page-flip) [107.198549] Starting subtest: fbc-psr-primary-page-flip [107.200888] Starting dynamic subtest: eDP-1 [107.205256] Dynamic subtest eDP-1: SKIP (0.000s) [107.209491] Subtest fbc-psr-primary-page-flip: SKIP (0.002s) [107.297738] [014/131] (912s left) i915_pm_rps (engine-order) [107.364705] Starting subtest: engine-order [112.290745] Subtest engine-order: SUCCESS (4.924s) [112.445538] [015/131] (907s left) gem_softpin (evict-active) [112.511056] Starting subtest: evict-active [112.521190] Subtest evict-active: SUCCESS (0.010s) [112.678315] [016/131] (907s left) syncobj_timeline (wait-delayed-signal) [112.734003] Starting subtest: wait-delayed-signal [112.836941] Subtest wait-delayed-signal: SUCCESS (0.102s) [112.944637] [017/131] (907s left) kms_panel_fitting (atomic-fastset) [113.044942] Starting subtest: atomic-fastset [113.047421] Starting dynamic subtest: pipe-A-eDP-1 [113.184458] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.141s) [113.195661] Starting dynamic subtest: pipe-B-eDP-1 [114.386550] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.201s) [114.398416] Starting dynamic subtest: pipe-C-eDP-1 [115.568893] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.182s) [115.580885] Starting dynamic subtest: pipe-D-eDP-1 [116.705055] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.135s) [116.707620] Subtest atomic-fastset: SUCCESS (3.662s) [117.971299] [018/131] (902s left) kms_big_fb (x-tiled-16bpp-rotate-270) [118.067561] Starting subtest: x-tiled-16bpp-rotate-270 [118.086303] Subtest x-tiled-16bpp-rotate-270: SKIP (0.018s) [118.233705] [019/131] (902s left) api_intel_bb (render-ccs) [118.289880] Starting subtest: render-ccs [118.635768] Subtest render-ccs: SUCCESS (0.346s) [118.782870] [020/131] (901s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [118.882507] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [118.884952] Starting dynamic subtest: pipe-A-eDP-1 [118.908577] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [118.919346] Starting dynamic subtest: pipe-B-eDP-1 [118.940794] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [118.949815] Starting dynamic subtest: pipe-C-eDP-1 [118.973157] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [118.982751] Starting dynamic subtest: pipe-D-eDP-1 [119.004867] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [119.009281] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s) [121.045642] [021/131] (899s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled) [121.105863] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled [121.207918] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s) [121.308282] [022/131] (899s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [121.423602] Starting subtest: psr-2p-primscrn-cur-indfb-move [121.427734] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [121.556305] [023/131] (898s left) gem_lmem_swapping (heavy-multi) [121.601442] Subtest heavy-multi: SKIP (0.000s) [121.648834] [024/131] (898s left) kms_async_flips (test-cursor) [121.753210] Starting subtest: test-cursor [121.757537] Subtest test-cursor: SKIP (0.000s) [122.976304] [025/131] (897s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-sf) [128.030840] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-sf [128.033260] Starting dynamic subtest: pipe-A-eDP-1 [128.835101] Dynamic subtest pipe-A-eDP-1: SKIP (0.801s) [128.845641] Starting dynamic subtest: pipe-B-eDP-1 [129.964477] Dynamic subtest pipe-B-eDP-1: SKIP (1.128s) [129.968866] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-sf: SKIP (1.933s) [131.174820] [026/131] (889s left) kms_plane_multiple (2x-tiling-4) [131.285163] Starting subtest: 2x-tiling-4 [131.289441] Subtest 2x-tiling-4: SKIP (0.000s) [131.378835] [027/131] (889s left) gem_ctx_param (invalid-param-set) [131.449537] Starting subtest: invalid-param-set [131.451952] Subtest invalid-param-set: SUCCESS (0.000s) [131.550142] [028/131] (889s left) kms_ccs (bad-pixel-format-y-tiled-ccs) [131.654763] Starting subtest: bad-pixel-format-y-tiled-ccs [131.657049] Starting dynamic subtest: pipe-A-eDP-1 [131.680013] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [131.690638] Starting dynamic subtest: pipe-B-eDP-1 [131.712257] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [131.720859] Starting dynamic subtest: pipe-C-eDP-1 [131.742022] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [131.751093] Starting dynamic subtest: pipe-D-eDP-1 [131.774611] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [131.778878] Subtest bad-pixel-format-y-tiled-ccs: SKIP (0.003s) [133.847312] [029/131] (886s left) kms_plane_scaling (plane-downscale-factor-0-5-with-modifiers) [133.938329] Starting subtest: plane-downscale-factor-0-5-with-modifiers [133.940717] Starting dynamic subtest: pipe-A [133.957763] Dynamic subtest pipe-A: SKIP (0.016s) [133.966575] Starting dynamic subtest: pipe-B [133.986534] Dynamic subtest pipe-B: SKIP (0.029s) [133.994767] Starting dynamic subtest: pipe-C [134.014524] Dynamic subtest pipe-C: SKIP (0.029s) [134.022779] Starting dynamic subtest: pipe-D [134.044958] Dynamic subtest pipe-D: SKIP (0.029s) [134.049285] Subtest plane-downscale-factor-0-5-with-modifiers: SKIP (0.103s) [134.169579] [030/131] (886s left) syncobj_timeline (multi-wait-all-available-submitted-signaled) [134.231695] Starting subtest: multi-wait-all-available-submitted-signaled [134.234051] Subtest multi-wait-all-available-submitted-signaled: SUCCESS (0.000s) [134.348315] [031/131] (886s left) perf (missing-sample-flags) [134.492316] Starting subtest: missing-sample-flags [134.494183] Subtest missing-sample-flags: SUCCESS (0.000s) [134.534089] [032/131] (886s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [134.629833] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [140.675998] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (6.051s) [141.844821] [033/131] (879s left) kms_pm_rpm (system-suspend-idle) [143.711642] Starting subtest: system-suspend-idle [163.178125] Subtest system-suspend-idle: SUCCESS (4.636s) [163.566749] [034/131] (857s left) kms_vblank (wait-forked) [163.680386] Starting subtest: wait-forked [163.682665] Starting dynamic subtest: pipe-A-eDP-1 [165.477819] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.800s) [165.491433] Starting dynamic subtest: pipe-D-eDP-1 [167.933628] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.452s) [167.935693] Subtest wait-forked: SUCCESS (4.255s) [168.828601] [035/131] (852s left) kms_big_fb (y-tiled-32bpp-rotate-0) [168.935473] Starting subtest: y-tiled-32bpp-rotate-0 [168.939748] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [169.042590] [036/131] (852s left) kms_pipe_crc_basic (read-crc) [169.133128] Starting subtest: read-crc [169.134977] Starting dynamic subtest: pipe-A-eDP-1 [169.835199] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [169.846084] Starting dynamic subtest: pipe-B-eDP-1 [171.168480] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.334s) [171.177800] Starting dynamic subtest: pipe-C-eDP-1 [172.446601] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.278s) [172.456227] Starting dynamic subtest: pipe-D-eDP-1 [173.818550] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.370s) [173.820562] Subtest read-crc: SUCCESS (4.685s) [174.662285] [037/131] (846s left) kms_cursor_legacy (single-move) [174.793311] Starting subtest: single-move [174.795210] Starting dynamic subtest: pipe-A [180.174109] Dynamic subtest pipe-A: SUCCESS (5.379s) [180.184849] Starting dynamic subtest: pipe-B [185.556437] Dynamic subtest pipe-B: SUCCESS (5.380s) [185.570364] Starting dynamic subtest: pipe-C [190.937958] Dynamic subtest pipe-C: SUCCESS (5.380s) [190.947073] Starting dynamic subtest: pipe-D [196.319247] Dynamic subtest pipe-D: SUCCESS (5.380s) [196.330411] Starting dynamic subtest: all-pipes [201.707703] Dynamic subtest all-pipes: SUCCESS (5.386s) [201.710363] Subtest single-move: SUCCESS (26.913s) [201.875524] [038/131] (819s left) kms_psr2_sf (pr-overlay-plane-move-continuous-exceed-sf) [207.011389] Starting subtest: pr-overlay-plane-move-continuous-exceed-sf [207.015804] Subtest pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s) [207.880769] [039/131] (813s left) gem_unref_active_buffers [208.116073] [040/131] (813s left) kms_psr (fbc-psr2-primary-mmap-gtt) [208.212965] Starting subtest: fbc-psr2-primary-mmap-gtt [208.215205] Starting dynamic subtest: eDP-1 [208.219313] Dynamic subtest eDP-1: SKIP (0.000s) [208.223418] Subtest fbc-psr2-primary-mmap-gtt: SKIP (0.001s) [208.308254] [041/131] (812s left) syncobj_wait (invalid-signal-zero-handles) [208.366021] Starting subtest: invalid-signal-zero-handles [208.367965] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [208.500006] [042/131] (812s left) gen9_exec_parse (bb-oversize) [208.556132] Subtest bb-oversize: SKIP (0.000s) [208.646162] [043/131] (812s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted) [208.704136] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted [208.804958] Subtest etime-multi-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s) [208.905941] [044/131] (812s left) gem_exec_reloc (basic-write-cpu-noreloc) [208.968616] Subtest basic-write-cpu-noreloc: SKIP (0.000s) [209.057506] [045/131] (812s left) gem_mmap_offset (bad-flags) [209.119687] Starting subtest: bad-flags [209.121804] Subtest bad-flags: SUCCESS (0.000s) [209.256005] [046/131] (812s left) kms_cursor_legacy (cursor-vs-flip-legacy) [209.374932] Starting subtest: cursor-vs-flip-legacy [238.592997] Subtest cursor-vs-flip-legacy: SUCCESS (29.215s) [239.423991] [047/131] (782s left) kms_rotation_crc (sprite-rotation-90-pos-100-0) [239.530048] Starting subtest: sprite-rotation-90-pos-100-0 [239.534450] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s) [239.627237] [048/131] (781s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [239.732200] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [240.721820] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (0.989s) [240.877866] [049/131] (780s left) gem_create (busy-create) [240.945098] Starting subtest: busy-create [240.947468] Starting dynamic subtest: smem0 [273.436677] Dynamic subtest smem0: SUCCESS (32.488s) [273.439187] Subtest busy-create: SUCCESS (32.490s) [273.649465] [050/131] (747s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render) [273.762381] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render [277.972588] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.213s) [279.127153] [051/131] (742s left) perf (invalid-open-flags) [279.227377] Starting subtest: invalid-open-flags [279.229781] Subtest invalid-open-flags: SUCCESS (0.000s) [279.268048] [052/131] (742s left) perf (oa-formats) [279.383340] Starting subtest: oa-formats [279.385369] Starting dynamic subtest: 0-rcs0 [279.398376] Dynamic subtest 0-rcs0: SUCCESS (0.015s) [279.408972] Starting dynamic subtest: 1-vcs1 [279.419693] Dynamic subtest 1-vcs1: SUCCESS (0.021s) [279.422041] Subtest oa-formats: SUCCESS (0.037s) [279.461034] [053/131] (742s left) kms_big_fb (4-tiled-8bpp-rotate-270) [279.579516] Starting subtest: 4-tiled-8bpp-rotate-270 [279.611063] Subtest 4-tiled-8bpp-rotate-270: SKIP (0.030s) [279.744459] [054/131] (742s left) kms_cursor_crc (cursor-onscreen-64x21) [279.929413] Starting subtest: cursor-onscreen-64x21 [279.972945] Subtest cursor-onscreen-64x21: SKIP (0.040s) [280.226299] [055/131] (741s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [280.326236] Starting subtest: primary-4-tiled-reflect-x-180 [287.296070] Subtest primary-4-tiled-reflect-x-180: SUCCESS (6.971s) [288.592519] [056/131] (733s left) kms_cursor_crc (cursor-onscreen-256x256) [288.829349] Starting subtest: cursor-onscreen-256x256 [288.834395] Starting dynamic subtest: pipe-A-eDP-1 [290.923862] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.088s) [290.955052] Starting dynamic subtest: pipe-D-eDP-1 [293.714254] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.763s) [293.716209] Subtest cursor-onscreen-256x256: SUCCESS (4.881s) [294.541851] [057/131] (727s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt) [294.641234] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt [301.987805] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.350s) [302.150645] [058/131] (719s left) kms_async_flips (async-flip-with-page-flip-events-tiled) [302.259030] Starting subtest: async-flip-with-page-flip-events-tiled [302.643699] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [305.421012] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.775s) [305.433788] Starting dynamic subtest: pipe-A-eDP-1-4 [307.595220] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.173s) [307.607775] Starting dynamic subtest: pipe-A-eDP-1-4 [309.605454] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s) [309.620266] Starting dynamic subtest: pipe-A-eDP-1-x [311.784424] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.178s) [312.161721] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [314.946086] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.792s) [314.961226] Starting dynamic subtest: pipe-B-eDP-1-4 [317.120290] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s) [317.131410] Starting dynamic subtest: pipe-B-eDP-1-4 [319.130488] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s) [319.139733] Starting dynamic subtest: pipe-B-eDP-1-x [321.308831] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.178s) [321.673512] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [324.472849] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.807s) [324.482165] Starting dynamic subtest: pipe-C-eDP-1-4 [326.648167] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s) [326.657333] Starting dynamic subtest: pipe-C-eDP-1-4 [328.658626] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [328.671318] Starting dynamic subtest: pipe-C-eDP-1-x [330.826392] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.167s) [331.189473] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [333.994314] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.813s) [334.003811] Starting dynamic subtest: pipe-D-eDP-1-4 [336.169580] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.174s) [336.179453] Starting dynamic subtest: pipe-D-eDP-1-4 [338.179849] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s) [338.189938] Starting dynamic subtest: pipe-D-eDP-1-x [340.358258] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.178s) [340.360474] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.100s) [341.595551] [059/131] (680s left) perf (polling) [341.702959] Starting subtest: polling [341.705409] Starting dynamic subtest: 0-rcs0 [351.736404] Dynamic subtest 0-rcs0: SUCCESS (10.032s) [351.751442] Starting dynamic subtest: 1-vecs0 [361.761004] Dynamic subtest 1-vecs0: SUCCESS (10.023s) [361.763895] Subtest polling: SUCCESS (20.057s) [361.811609] [060/131] (660s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-mmap-wc) [361.931379] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-mmap-wc [361.935732] Subtest psr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [362.062137] [061/131] (659s left) syncobj_timeline (reset-signaled) [362.119961] Starting subtest: reset-signaled [362.122120] Subtest reset-signaled: SUCCESS (0.000s) [362.243967] [062/131] (659s left) kms_rmfb (rmfb-ioctl) [362.338144] Starting subtest: rmfb-ioctl [362.340337] Starting dynamic subtest: pipe-A-eDP-1 [362.444402] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [362.458275] Starting dynamic subtest: pipe-B-eDP-1 [363.628986] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.181s) [363.641956] Starting dynamic subtest: pipe-C-eDP-1 [364.758786] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.127s) [364.771660] Starting dynamic subtest: pipe-D-eDP-1 [365.892077] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.130s) [365.894332] Subtest rmfb-ioctl: SUCCESS (3.555s) [367.126666] [063/131] (655s left) gem_userptr_blits (create-destroy-sync) [367.226868] Starting subtest: create-destroy-sync [372.243098] Subtest create-destroy-sync: SUCCESS (5.015s) [372.411244] [064/131] (649s left) gem_exec_reloc (basic-gtt-cpu-active) [372.479323] Subtest basic-gtt-cpu-active: SKIP (0.000s) [372.563341] [065/131] (649s left) api_intel_allocator (execbuf-with-allocator) [372.641971] Starting subtest: execbuf-with-allocator [372.650967] Subtest execbuf-with-allocator: SUCCESS (0.010s) [372.764997] [066/131] (649s left) kms_lease (cursor-implicit-plane) [372.876078] Starting subtest: cursor-implicit-plane [372.877998] Starting dynamic subtest: pipe-A-eDP-1 [373.331892] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.457s) [373.342018] Starting dynamic subtest: pipe-B-eDP-1 [374.425652] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.089s) [374.435903] Starting dynamic subtest: pipe-C-eDP-1 [375.541973] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.114s) [375.551488] Starting dynamic subtest: pipe-D-eDP-1 [376.676770] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s) [376.679014] Subtest cursor-implicit-plane: SUCCESS (3.801s) [377.558380] [067/131] (644s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [377.674895] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [377.679779] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [377.865162] [068/131] (644s left) syncobj_wait (invalid-signal-illegal-handle) [377.921137] Starting subtest: invalid-signal-illegal-handle [377.923616] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [378.057341] [069/131] (644s left) kms_psr (psr-primary-blt) [378.160174] Starting subtest: psr-primary-blt [378.162416] Starting dynamic subtest: eDP-1 [379.928203] Dynamic subtest eDP-1: SUCCESS (1.769s) [379.930546] Subtest psr-primary-blt: SUCCESS (1.770s) [380.823623] [070/131] (641s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [380.923828] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [380.926191] Starting dynamic subtest: pipe-A-eDP-1 [380.982371] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [380.993155] Starting dynamic subtest: pipe-B-eDP-1 [381.049344] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [381.058520] Starting dynamic subtest: pipe-C-eDP-1 [381.115284] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [381.125502] Starting dynamic subtest: pipe-D-eDP-1 [381.182003] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [381.186022] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [383.196968] [071/131] (639s left) kms_psr (pr-primary-blt) [383.286474] Starting subtest: pr-primary-blt [383.290603] Subtest pr-primary-blt: SKIP (0.000s) [383.385206] [072/131] (639s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [383.486367] Starting subtest: psr-2p-primscrn-spr-indfb-move [383.490502] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [383.593778] [073/131] (638s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-downscaling) [383.689163] Starting subtest: flip-64bpp-linear-to-16bpp-linear-downscaling [383.691431] Starting dynamic subtest: pipe-A-default-mode [384.827524] Dynamic subtest pipe-A-default-mode: SKIP (1.136s) [384.831808] Subtest flip-64bpp-linear-to-16bpp-linear-downscaling: SKIP (1.138s) [385.020087] [074/131] (637s left) gem_exec_schedule (u-semaphore-noskip) [385.096664] Starting subtest: u-semaphore-noskip [385.488377] Subtest u-semaphore-noskip: SUCCESS (0.398s) [385.854604] [075/131] (636s left) i915_drm_fdinfo (memory-info-idle) [385.902419] Starting subtest: memory-info-idle [385.904675] Starting dynamic subtest: smem0 [385.940255] Dynamic subtest smem0: SUCCESS (0.040s) [385.942646] Subtest memory-info-idle: SUCCESS (0.041s) [386.041280] [076/131] (636s left) i915_selftest (live) [389.560342] Starting subtest: live [389.562744] Starting dynamic subtest: sanitycheck [392.313234] Dynamic subtest sanitycheck: SUCCESS (2.753s) [392.322253] Starting dynamic subtest: uncore [396.760209] Dynamic subtest uncore: SUCCESS (4.444s) [396.769892] Starting dynamic subtest: workarounds [400.103595] Dynamic subtest workarounds: SUCCESS (3.322s) [400.113985] Starting dynamic subtest: gt_engines [404.728276] Dynamic subtest gt_engines: SUCCESS (4.641s) [404.738488] Starting dynamic subtest: gt_timelines [420.864653] Dynamic subtest gt_timelines: SUCCESS (16.133s) [420.876212] Starting dynamic subtest: gt_contexts [423.732872] Dynamic subtest gt_contexts: SUCCESS (2.866s) [423.743377] Starting dynamic subtest: gt_lrc [429.982957] Dynamic subtest gt_lrc: SUCCESS (6.249s) [429.997825] Starting dynamic subtest: gt_mocs [433.034966] Dynamic subtest gt_mocs: SUCCESS (3.050s) [433.044626] Starting dynamic subtest: gt_pm [439.951636] Dynamic subtest gt_pm: SUCCESS (6.914s) [439.961284] Starting dynamic subtest: gt_heartbeat [444.406599] Dynamic subtest gt_heartbeat: SUCCESS (4.452s) [444.415574] Starting dynamic subtest: gt_tlb [453.858959] Dynamic subtest gt_tlb: SUCCESS (9.450s) [453.869003] Starting dynamic subtest: requests [467.695311] Dynamic subtest requests: SUCCESS (13.834s) [467.705338] Starting dynamic subtest: migrate [473.818881] Dynamic subtest migrate: SUCCESS (6.120s) [473.828836] Starting dynamic subtest: active [476.578295] Dynamic subtest active: SUCCESS (2.758s) [476.588115] Starting dynamic subtest: objects [481.389528] Dynamic subtest objects: SUCCESS (4.809s) [481.398776] Starting dynamic subtest: mman [486.275896] Dynamic subtest mman: SUCCESS (4.884s) [486.285963] Starting dynamic subtest: dmabuf [490.787260] Dynamic subtest dmabuf: SUCCESS (4.509s) [490.797143] Starting dynamic subtest: vma [495.186841] Dynamic subtest vma: SUCCESS (4.398s) [495.195637] Starting dynamic subtest: coherency [500.249279] Dynamic subtest coherency: SUCCESS (5.060s) [500.259220] Starting dynamic subtest: gtt [512.306109] Dynamic subtest gtt: SUCCESS (12.055s) [512.316265] Starting dynamic subtest: gem [520.236629] Dynamic subtest gem: SUCCESS (7.929s) [520.246315] Starting dynamic subtest: evict [525.707201] Dynamic subtest evict: SUCCESS (5.468s) [525.714537] Starting dynamic subtest: hugepages [536.820454] Dynamic subtest hugepages: SUCCESS (11.111s) [536.831181] Starting dynamic subtest: gem_contexts [565.119850] Dynamic subtest gem_contexts: SUCCESS (28.271s) [565.130354] Starting dynamic subtest: client [569.582407] Dynamic subtest client: SUCCESS (4.487s) [569.592682] Starting dynamic subtest: gem_migrate [573.987904] Dynamic subtest gem_migrate: SUCCESS (4.404s) [573.997446] Starting dynamic subtest: reset [578.361289] Dynamic subtest reset: SUCCESS (4.371s) [578.371754] Starting dynamic subtest: memory_region [582.796883] Dynamic subtest memory_region: SUCCESS (4.434s) [582.806959] Starting dynamic subtest: hangcheck [596.472329] Dynamic subtest hangcheck: SUCCESS (13.673s) [596.482691] Starting dynamic subtest: execlists [600.920487] Dynamic subtest execlists: SUCCESS (4.446s) [600.930791] Starting dynamic subtest: ring_submission [605.324887] Dynamic subtest ring_submission: SUCCESS (4.403s) [605.334825] Starting dynamic subtest: perf [609.777898] Dynamic subtest perf: SUCCESS (4.450s) [609.787659] Starting dynamic subtest: slpc [623.995317] Dynamic subtest slpc: SUCCESS (14.215s) [624.005103] Starting dynamic subtest: guc [627.846930] Dynamic subtest guc: SUCCESS (3.850s) [627.856724] Starting dynamic subtest: guc_multi_lrc [630.736815] Dynamic subtest guc_multi_lrc: SUCCESS (2.888s) [630.746491] Starting dynamic subtest: guc_hang [635.837194] Dynamic subtest guc_hang: SUCCESS (5.098s) [635.847326] Starting dynamic subtest: late_gt_pm [640.535224] Dynamic subtest late_gt_pm: SUCCESS (4.696s) [640.537676] Subtest live: SUCCESS (250.972s) [640.564211] [FACT i915_selftest (live)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [640.564947] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true [640.568126] [077/131] (382s left) gem_userptr_blits (nohangcheck) [642.118253] Starting subtest: nohangcheck [642.376108] Subtest nohangcheck: SUCCESS (0.260s) [642.491820] [FACT gem_userptr_blits (nohangcheck)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [642.492969] [FACT gem_userptr_blits (nohangcheck)] new: kernel.kmod_is_loaded.i915: true [642.497187] [078/131] (380s left) kms_ccs (crc-primary-basic-4-tiled-mtl-rc-ccs) [642.614854] Starting subtest: crc-primary-basic-4-tiled-mtl-rc-ccs [642.617231] Starting dynamic subtest: pipe-A-eDP-1 [643.475758] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.853s) [643.484832] Starting dynamic subtest: pipe-B-eDP-1 [645.061732] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.583s) [645.071699] Starting dynamic subtest: pipe-C-eDP-1 [646.518531] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.456s) [646.529004] Starting dynamic subtest: pipe-D-eDP-1 [648.048137] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.528s) [648.050033] Subtest crc-primary-basic-4-tiled-mtl-rc-ccs: SUCCESS (5.426s) [649.268030] [079/131] (373s left) gem_softpin (allocator-nopin) [649.325629] Starting subtest: allocator-nopin [649.425484] Subtest allocator-nopin: SUCCESS (0.099s) [649.594215] [080/131] (373s left) kms_draw_crc (draw-method-pwrite) [649.698583] Starting subtest: draw-method-pwrite [649.700976] Starting dynamic subtest: xrgb8888-untiled [650.240788] Dynamic subtest xrgb8888-untiled: SUCCESS (0.544s) [650.257710] Starting dynamic subtest: rgb565-untiled [650.673974] Dynamic subtest rgb565-untiled: SUCCESS (0.432s) [650.683331] Starting dynamic subtest: xrgb2101010-untiled [651.184895] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.510s) [651.193946] Starting dynamic subtest: xbgr16161616f-untiled [651.896283] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.710s) [651.905028] Starting dynamic subtest: xrgb8888-xtiled [653.574268] Dynamic subtest xrgb8888-xtiled: SUCCESS (1.677s) [653.583508] Starting dynamic subtest: rgb565-xtiled [654.596510] Dynamic subtest rgb565-xtiled: SUCCESS (1.021s) [654.605983] Starting dynamic subtest: xrgb2101010-xtiled [656.264617] Dynamic subtest xrgb2101010-xtiled: SUCCESS (1.666s) [656.273880] Starting dynamic subtest: xbgr16161616f-xtiled [659.341637] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (3.077s) [659.353062] Starting dynamic subtest: xrgb8888-4tiled [660.375252] Dynamic subtest xrgb8888-4tiled: SUCCESS (1.033s) [660.384043] Starting dynamic subtest: rgb565-4tiled [660.908174] Dynamic subtest rgb565-4tiled: SUCCESS (0.532s) [660.918110] Starting dynamic subtest: xrgb2101010-4tiled [661.919171] Dynamic subtest xrgb2101010-4tiled: SUCCESS (1.010s) [661.928696] Starting dynamic subtest: xbgr16161616f-4tiled [664.730806] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (2.810s) [664.733200] Subtest draw-method-pwrite: SUCCESS (15.034s) [664.859930] [081/131] (358s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip) [664.979997] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip [664.984639] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s) [665.123465] [082/131] (357s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt) [665.222507] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt [665.226871] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [665.361901] [083/131] (357s left) syncobj_timeline (host-signal-points) [665.411823] Starting subtest: host-signal-points [665.416682] Subtest host-signal-points: SUCCESS (0.004s) [665.555260] [084/131] (357s left) gem_mmap_gtt (basic-small-bo) [665.617591] Subtest basic-small-bo: SKIP (0.000s) [665.685077] [085/131] (357s left) perf_pmu (semaphore-wait-idle) [665.723556] Starting subtest: semaphore-wait-idle [665.725400] Starting dynamic subtest: rcs0 [666.238981] Dynamic subtest rcs0: SUCCESS (0.513s) [666.250893] Starting dynamic subtest: bcs0 [666.752573] Dynamic subtest bcs0: SUCCESS (0.510s) [666.764772] Starting dynamic subtest: vcs0 [667.266283] Dynamic subtest vcs0: SUCCESS (0.510s) [667.279126] Starting dynamic subtest: vcs1 [667.781835] Dynamic subtest vcs1: SUCCESS (0.513s) [667.792824] Starting dynamic subtest: vecs0 [668.298178] Dynamic subtest vecs0: SUCCESS (0.512s) [668.308791] Starting dynamic subtest: ccs0 [668.812974] Dynamic subtest ccs0: SUCCESS (0.512s) [668.815806] Subtest semaphore-wait-idle: SUCCESS (3.089s) [668.968961] [086/131] (354s left) kms_addfb_basic (no-handle) [669.033726] Starting subtest: no-handle [669.036056] Subtest no-handle: SUCCESS (0.000s) [669.209517] [087/131] (353s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite) [669.315658] Starting subtest: fbcpsr-rgb101010-draw-pwrite [677.126004] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (7.812s) [677.265226] [088/131] (345s left) gem_render_copy (yf-tiled-ccs-to-linear) [677.319161] Starting subtest: yf-tiled-ccs-to-linear [677.323218] Subtest yf-tiled-ccs-to-linear: SKIP (0.000s) [677.526774] [089/131] (345s left) kms_flip (wf_vblank-ts-check) [677.630148] Starting subtest: wf_vblank-ts-check [677.632298] Starting dynamic subtest: A-eDP1 [686.573655] Dynamic subtest A-eDP1: SUCCESS (8.945s) [686.586305] Starting dynamic subtest: B-eDP1 [695.508632] Dynamic subtest B-eDP1: SUCCESS (8.933s) [695.520568] Starting dynamic subtest: C-eDP1 [704.430862] Dynamic subtest C-eDP1: SUCCESS (8.919s) [704.442165] Starting dynamic subtest: D-eDP1 [713.359000] Dynamic subtest D-eDP1: SUCCESS (8.925s) [713.361289] Subtest wf_vblank-ts-check: SUCCESS (35.731s) [714.613564] [090/131] (308s left) gem_exec_schedule (deep) [714.801252] Starting subtest: deep [714.803518] Starting dynamic subtest: rcs0 [719.441716] Dynamic subtest rcs0: SKIP (4.639s) [719.452955] Starting dynamic subtest: vcs0 [730.268021] Dynamic subtest vcs0: SUCCESS (10.827s) [730.280829] Starting dynamic subtest: vcs1 [740.832955] Dynamic subtest vcs1: SUCCESS (10.562s) [740.842790] Starting dynamic subtest: vecs0 [751.386241] Dynamic subtest vecs0: SUCCESS (10.553s) [751.399433] Starting dynamic subtest: ccs0 [763.523268] Dynamic subtest ccs0: SUCCESS (12.135s) [763.526557] Subtest deep: SUCCESS (48.720s) [764.990489] [091/131] (258s left) kms_sequence (queue-idle) [765.094622] Starting subtest: queue-idle [765.096681] Starting dynamic subtest: pipe-A-eDP-1 [766.913619] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.819s) [766.924348] Starting dynamic subtest: pipe-B-eDP-1 [769.348221] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.432s) [769.358407] Starting dynamic subtest: pipe-C-eDP-1 [771.773989] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.426s) [771.785094] Starting dynamic subtest: pipe-D-eDP-1 [774.202250] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.426s) [774.204647] Subtest queue-idle: SUCCESS (9.108s) [775.031677] [092/131] (248s left) gem_gtt_cpu_tlb [775.163386] [093/131] (248s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [775.276823] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [781.828965] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.562s) [781.965234] [094/131] (241s left) gem_eio (create-ext) [782.180884] Starting subtest: create-ext [782.486852] Subtest create-ext: SUCCESS (0.307s) [782.670817] [095/131] (240s left) gem_partial_pwrite_pread (writes-after-reads-uncached) [782.736823] Subtest writes-after-reads-uncached: SKIP (0.000s) [782.824847] [096/131] (240s left) sysfs_preempt_timeout (idempotent) [782.893606] Starting subtest: idempotent [782.895636] Starting dynamic subtest: vecs0 [782.897490] Dynamic subtest vecs0: SUCCESS (0.000s) [782.907940] Starting dynamic subtest: ccs0 [782.909751] Dynamic subtest ccs0: SUCCESS (0.000s) [782.918348] Starting dynamic subtest: vcs0 [782.920178] Dynamic subtest vcs0: SUCCESS (0.000s) [782.928625] Starting dynamic subtest: bcs0 [782.930398] Dynamic subtest bcs0: SUCCESS (0.000s) [782.939103] Starting dynamic subtest: rcs0 [782.940863] Dynamic subtest rcs0: SUCCESS (0.000s) [782.949392] Starting dynamic subtest: vcs1 [782.951213] Dynamic subtest vcs1: SUCCESS (0.000s) [782.953050] Subtest idempotent: SUCCESS (0.006s) [783.035329] [097/131] (240s left) gem_busy (semaphore) [783.221899] Subtest semaphore: SKIP (0.000s) [783.476354] [098/131] (240s left) sriov_basic (enable-vfs-bind-unbind-each) [783.532615] Starting subtest: enable-vfs-bind-unbind-each [783.534952] Starting dynamic subtest: numvfs-1 [783.614500] Dynamic subtest numvfs-1: FAIL (0.029s) [783.626459] Starting dynamic subtest: numvfs-2 [783.698601] Dynamic subtest numvfs-2: FAIL (0.003s) [783.710833] Starting dynamic subtest: numvfs-3 [783.786170] Dynamic subtest numvfs-3: FAIL (0.003s) [783.797511] Starting dynamic subtest: numvfs-4 [783.872960] Dynamic subtest numvfs-4: FAIL (0.003s) [783.885149] Starting dynamic subtest: numvfs-5 [783.960392] Dynamic subtest numvfs-5: FAIL (0.004s) [783.970946] Starting dynamic subtest: numvfs-6 [784.044142] Dynamic subtest numvfs-6: FAIL (0.003s) [784.054982] Starting dynamic subtest: numvfs-7 [784.128628] Dynamic subtest numvfs-7: FAIL (0.004s) [784.139298] Starting dynamic subtest: numvfs-random [784.211892] Dynamic subtest numvfs-random: FAIL (0.003s) [784.213971] Subtest enable-vfs-bind-unbind-each: FAIL (0.059s) [784.253454] [099/131] (239s left) kms_pm_lpsp (screens-disabled) [785.353836] Starting subtest: screens-disabled [785.357823] Subtest screens-disabled: SKIP (0.000s) [785.448636] [100/131] (238s left) gem_exec_capture (capture-invisible) [785.517812] Starting subtest: capture-invisible [785.520089] Starting dynamic subtest: smem0 [785.524094] Dynamic subtest smem0: SKIP (0.000s) [785.528039] Subtest capture-invisible: SKIP (0.001s) [785.652667] [101/131] (238s left) gem_lmem_swapping (verify-ccs) [785.691171] Subtest verify-ccs: SKIP (0.000s) [785.732904] [102/131] (238s left) kms_joiner (basic-force-ultra-joiner) [785.838875] Starting subtest: basic-force-ultra-joiner [785.843116] Subtest basic-force-ultra-joiner: SKIP (0.000s) [785.922495] [103/131] (237s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc) [786.027846] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc [792.557775] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.531s) [792.742071] [104/131] (231s left) kms_color (legacy-gamma) [792.842227] Starting subtest: legacy-gamma [792.844525] Starting dynamic subtest: pipe-A-eDP-1 [793.572984] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.728s) [793.583256] Starting dynamic subtest: pipe-B-eDP-1 [794.937023] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.363s) [794.948036] Starting dynamic subtest: pipe-C-eDP-1 [796.340114] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.403s) [796.349967] Starting dynamic subtest: pipe-D-eDP-1 [797.643997] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.301s) [797.646422] Subtest legacy-gamma: SUCCESS (4.800s) [798.491026] [105/131] (225s left) gem_exec_schedule (wide) [798.691854] Starting subtest: wide [798.693944] Starting dynamic subtest: rcs0 [808.608780] Dynamic subtest rcs0: SUCCESS (9.916s) [808.621160] Starting dynamic subtest: vcs0 [821.118867] Dynamic subtest vcs0: SUCCESS (12.510s) [821.132267] Starting dynamic subtest: vcs1 [830.673990] Dynamic subtest vcs1: SUCCESS (9.554s) [830.686871] Starting dynamic subtest: vecs0 [841.395590] Dynamic subtest vecs0: SUCCESS (10.720s) [841.408191] Starting dynamic subtest: ccs0 [854.934362] Dynamic subtest ccs0: SUCCESS (13.538s) [854.936843] Subtest wide: SUCCESS (56.243s) [856.445843] [106/131] (167s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling) [856.542798] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling [856.545141] Starting dynamic subtest: pipe-A-default-mode [856.833214] Dynamic subtest pipe-A-default-mode: SKIP (0.288s) [856.837900] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.290s) [857.719695] [107/131] (166s left) kms_big_fb (linear-64bpp-rotate-180) [857.817509] Starting subtest: linear-64bpp-rotate-180 [859.286395] Subtest linear-64bpp-rotate-180: SUCCESS (1.467s) [859.500273] [108/131] (164s left) gem_ppgtt (blt-vs-render-ctxn) [859.558247] Starting subtest: blt-vs-render-ctxN [892.667602] Subtest blt-vs-render-ctxN: SUCCESS (33.106s) [892.836623] [109/131] (131s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-plflip-blt) [892.994716] Starting subtest: psr-2p-scndscrn-shrfb-plflip-blt [892.999129] Subtest psr-2p-scndscrn-shrfb-plflip-blt: SKIP (0.000s) [893.137082] [110/131] (131s left) kms_chamelium_frames (dp-frame-dump) [893.515538] Subtest dp-frame-dump: SKIP (0.000s) [894.307378] [111/131] (129s left) kms_psr2_su (page_flip-nv12) [894.374689] Subtest page_flip-NV12: SKIP (0.000s) [894.455485] [112/131] (129s left) gem_tiling_max_stride [894.576438] [113/131] (129s left) perf_pmu (busy-idle) [894.620878] Starting subtest: busy-idle [894.623182] Starting dynamic subtest: rcs0 [895.335255] Dynamic subtest rcs0: SUCCESS (0.714s) [895.347848] Starting dynamic subtest: bcs0 [896.009766] Dynamic subtest bcs0: SUCCESS (0.672s) [896.022474] Starting dynamic subtest: vcs0 [897.404210] Dynamic subtest vcs0: SUCCESS (1.391s) [897.415108] Starting dynamic subtest: vcs1 [899.387245] Dynamic subtest vcs1: SUCCESS (1.980s) [899.400110] Starting dynamic subtest: vecs0 [901.371094] Dynamic subtest vecs0: SUCCESS (1.980s) [901.383950] Starting dynamic subtest: ccs0 [902.052032] Dynamic subtest ccs0: SUCCESS (0.680s) [902.054412] Subtest busy-idle: SUCCESS (7.433s) [902.207817] [114/131] (122s left) dmabuf_sync_file (export-before-signal) [902.247522] Starting subtest: export-before-signal [902.249433] Subtest export-before-signal: SUCCESS (0.000s) [902.332889] [115/131] (122s left) gem_exec_reloc (basic-cpu-read) [902.397204] Subtest basic-cpu-read: SKIP (0.000s) [902.478594] [116/131] (121s left) kms_hdr (bpc-switch) [902.582968] Starting subtest: bpc-switch [903.684356] Starting dynamic subtest: pipe-A-eDP-1 [907.173064] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.488s) [907.175271] Subtest bpc-switch: SUCCESS (4.591s) [907.326073] [117/131] (117s left) perf (i915-ref-count) [907.437691] Starting subtest: i915-ref-count [907.509012] Subtest i915-ref-count: SUCCESS (0.069s) [907.564397] [118/131] (116s left) gem_ctx_isolation (nonpriv) [907.643298] Starting subtest: nonpriv [907.645550] Starting dynamic subtest: rcs0 [907.866333] Dynamic subtest rcs0: SUCCESS (0.223s) [907.879516] Starting dynamic subtest: bcs0 [908.146085] Dynamic subtest bcs0: SUCCESS (0.279s) [908.159275] Starting dynamic subtest: vcs0 [908.415301] Dynamic subtest vcs0: SUCCESS (0.268s) [908.428492] Starting dynamic subtest: vcs1 [909.609763] Dynamic subtest vcs1: SUCCESS (1.194s) [909.622294] Starting dynamic subtest: vecs0 [911.614190] Dynamic subtest vecs0: SUCCESS (2.004s) [911.627004] Starting dynamic subtest: ccs0 [913.686923] Dynamic subtest ccs0: SUCCESS (2.072s) [913.689326] Subtest nonpriv: SUCCESS (6.044s) [913.961546] [119/131] (110s left) gem_render_copy (y-tiled-to-vebox-x-tiled) [914.038309] Starting subtest: y-tiled-to-vebox-x-tiled [914.042404] Subtest y-tiled-to-vebox-x-tiled: SKIP (0.000s) [914.250874] [120/131] (110s left) kms_atomic_transition (plane-use-after-nonblocking-unbind) [914.345883] Starting subtest: plane-use-after-nonblocking-unbind [914.348211] Starting dynamic subtest: pipe-A-eDP-1 [914.407017] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.062s) [914.718555] Starting dynamic subtest: pipe-B-eDP-1 [915.533961] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.824s) [915.828496] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.484s) [916.708899] [121/131] (107s left) i915_hangman (engine-error-state-capture) [916.788498] Starting subtest: engine-error-state-capture [916.790833] Starting dynamic subtest: rcs0 [920.281418] Dynamic subtest rcs0: SUCCESS (3.493s) [920.294732] Starting dynamic subtest: bcs0 [925.336570] Dynamic subtest bcs0: SUCCESS (5.053s) [925.349364] Starting dynamic subtest: vcs0 [931.290408] Dynamic subtest vcs0: SUCCESS (5.951s) [931.305611] Starting dynamic subtest: vcs1 [937.371476] Dynamic subtest vcs1: SUCCESS (6.078s) [937.382127] Starting dynamic subtest: vecs0 [942.360974] Dynamic subtest vecs0: SUCCESS (4.987s) [942.374471] Starting dynamic subtest: ccs0 [948.312269] Dynamic subtest ccs0: SUCCESS (5.948s) [948.315138] Subtest engine-error-state-capture: SUCCESS (31.526s) [948.425374] [122/131] ( 76s left) gem_exec_schedule (pi-shared-iova) [948.626595] Starting subtest: pi-shared-iova [948.628997] Starting dynamic subtest: rcs0 [948.761950] Dynamic subtest rcs0: SUCCESS (0.138s) [948.776100] Starting dynamic subtest: vcs0 [948.851355] Dynamic subtest vcs0: SUCCESS (0.089s) [948.865536] Starting dynamic subtest: vcs1 [948.938889] Dynamic subtest vcs1: SUCCESS (0.087s) [948.951149] Starting dynamic subtest: vecs0 [949.021495] Dynamic subtest vecs0: SUCCESS (0.080s) [949.037526] Starting dynamic subtest: ccs0 [949.133304] Dynamic subtest ccs0: SUCCESS (0.111s) [949.135935] Subtest pi-shared-iova: SUCCESS (0.511s) [950.462150] [123/131] ( 74s left) syncobj_wait (invalid-reset-illegal-handle) [950.541509] Starting subtest: invalid-reset-illegal-handle [950.543896] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s) [950.684358] [124/131] ( 74s left) syncobj_wait (single-wait-all-for-submit-signaled) [950.734247] Starting subtest: single-wait-all-for-submit-signaled [950.736609] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s) [950.870760] [125/131] ( 73s left) kms_cursor_crc (cursor-sliding-512x170) [951.151804] Starting subtest: cursor-sliding-512x170 [951.156390] Subtest cursor-sliding-512x170: SKIP (0.001s) [951.351265] [126/131] ( 73s left) kms_chamelium_hpd (hdmi-hpd-fast) [951.747176] Subtest hdmi-hpd-fast: SKIP (0.000s) [952.578558] [127/131] ( 72s left) gem_ctx_persistence (hostile) [952.642791] Starting subtest: hostile [962.809426] Subtest hostile: SUCCESS (10.161s) [962.972514] [128/131] ( 62s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt) [963.088386] Starting subtest: fbc-rgb565-draw-blt [967.367792] Subtest fbc-rgb565-draw-blt: SUCCESS (4.284s) [968.547511] [129/131] ( 56s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite) [968.661570] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite [977.929177] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (9.269s) [978.083616] [130/131] ( 46s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [978.190268] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [978.194485] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [978.305115] [131/131] ( 46s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-move) [978.412311] Starting subtest: fbc-2p-scndscrn-spr-indfb-move [978.416353] Subtest fbc-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [978.554325] 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.