[56.620373] Initializing watchdogs
[56.620419]   /dev/watchdog0
[56.635196] [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.639704] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.642077] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.645428] [001/131] (960s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[56.738784] Starting subtest: y-tiled-ccs-to-yf-tiled
[56.743437] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[56.939121] [002/131] (960s left) gem_exec_whisper (basic-fds-priority-all)
[57.017752] Starting subtest: basic-fds-priority-all
[80.825837] Subtest basic-fds-priority-all: SUCCESS (23.721s)
[81.029510] [003/131] (936s left) gem_exec_balancer (parallel-keep-in-fence)
[81.286312] Starting subtest: parallel-keep-in-fence
[82.451343] Subtest parallel-keep-in-fence: SUCCESS (1.163s)
[82.605370] [004/131] (934s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-msflip-blt)
[82.718303] Starting subtest: psr-2p-scndscrn-indfb-msflip-blt
[82.722572] Subtest psr-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[82.829292] [005/131] (934s left) gem_ctx_exec (basic)
[82.894729] Starting subtest: basic
[82.901944] Subtest basic: SUCCESS (0.008s)
[83.056846] [006/131] (934s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[83.157614] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[89.984831] Subtest psr-1p-primscrn-spr-indfb-draw-render: SUCCESS (6.827s)
[90.155157] [007/131] (927s left) kms_content_protection (dp-mst-type-0)
[90.302782] Starting subtest: dp-mst-type-0
[90.307522] Subtest dp-mst-type-0: SKIP (0.000s)
[90.456380] [008/131] (926s left) kms_pipe_b_c_ivb (enable-pipe-c-while-b-has-3-lanes)
[90.514782] Subtest enable-pipe-C-while-B-has-3-lanes: SKIP (0.000s)
[90.574794] [009/131] (926s left) gem_mmap_offset (mmap-unmap)
[90.628235] Starting subtest: mmap-unmap
[90.630615] Starting dynamic subtest: smem0
[113.704056] Dynamic subtest smem0: SUCCESS (23.070s)
[113.706679] Subtest mmap-unmap: SUCCESS (23.071s)
[113.824969] [010/131] (903s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[113.888030] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[113.995883] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[114.092349] [011/131] (903s left) kms_flip (2x-flip-vs-dpms-on-nop-interruptible)
[114.200229] Starting subtest: 2x-flip-vs-dpms-on-nop-interruptible
[114.211568] Subtest 2x-flip-vs-dpms-on-nop-interruptible: SKIP (0.011s)
[114.305193] [012/131] (903s left) syncobj_basic (illegal-fd-to-handle)
[114.361988] Starting subtest: illegal-fd-to-handle
[114.364366] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[114.491903] [013/131] (903s left) syncobj_wait (invalid-wait-illegal-handle)
[114.544950] Starting subtest: invalid-wait-illegal-handle
[114.547273] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[114.650827] [014/131] (902s left) dumb_buffer (invalid-bpp)
[114.704018] Starting subtest: invalid-bpp
[114.705996] Subtest invalid-bpp: SUCCESS (0.000s)
[114.822246] [015/131] (902s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-blt)
[114.924158] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-blt
[114.928122] Subtest psr-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[115.030132] [016/131] (902s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc)
[115.129466] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc
[115.131104] Starting dynamic subtest: pipe-A-eDP-1
[130.954286] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.540s)
[130.965324] Starting dynamic subtest: pipe-B-eDP-1
[150.252622] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.673s)
[150.263074] Starting dynamic subtest: pipe-C-eDP-1
[167.897310] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.338s)
[167.907165] Starting dynamic subtest: pipe-D-eDP-1
[184.858699] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.313s)
[184.861391] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (10.867s)
[186.090911] [017/131] (831s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[186.187586] Starting subtest: sprite-rotation-90-pos-100-0
[186.192770] Subtest sprite-rotation-90-pos-100-0: SKIP (0.001s)
[186.270167] [018/131] (831s left) kms_pm_rpm (cursor-dpms)
[187.830831] Starting subtest: cursor-dpms
[187.836594] Subtest cursor-dpms: SKIP (0.000s)
[188.583439] [019/131] (829s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[188.668396] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[188.670877] Starting dynamic subtest: pipe-A
[189.938268] Dynamic subtest pipe-A: SUCCESS (1.251s)
[189.949211] Starting dynamic subtest: pipe-B
[192.273382] Dynamic subtest pipe-B: SUCCESS (2.307s)
[192.281790] Starting dynamic subtest: pipe-C
[193.423684] Dynamic subtest pipe-C: SUCCESS (1.138s)
[193.432355] Starting dynamic subtest: pipe-D
[194.672796] Dynamic subtest pipe-D: SUCCESS (1.239s)
[194.675717] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.939s)
[195.871851] [020/131] (821s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-submitted-signaled)
[195.930782] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled
[195.933738] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[196.055256] [021/131] (821s left) i915_pm_rps (min-max-config-idle)
[196.113081] Starting subtest: min-max-config-idle
[196.118626] Subtest min-max-config-idle: SKIP (0.001s)
[196.232599] [022/131] (821s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[196.336727] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[196.342692] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[196.461546] [023/131] (821s left) gem_mmap_wc (close)
[196.523376] Subtest close: SKIP (0.000s)
[196.576290] [024/131] (821s left) syncobj_timeline (reset-signaled)
[196.632849] Starting subtest: reset-signaled
[196.635924] Subtest reset-signaled: SUCCESS (0.000s)
[196.748541] [025/131] (821s left) i915_hangman (engine-engine-error)
[196.816555] Starting subtest: engine-engine-error
[196.818705] Starting dynamic subtest: rcs0
[198.607957] Dynamic subtest rcs0: SUCCESS (1.780s)
[198.619078] Starting dynamic subtest: bcs0
[200.588192] Dynamic subtest bcs0: SUCCESS (1.970s)
[200.600723] Starting dynamic subtest: vcs0
[202.571670] Dynamic subtest vcs0: SUCCESS (1.975s)
[202.584597] Starting dynamic subtest: vcs1
[204.556677] Dynamic subtest vcs1: SUCCESS (1.978s)
[204.566552] Starting dynamic subtest: vecs0
[206.605431] Dynamic subtest vecs0: SUCCESS (2.042s)
[206.616347] Starting dynamic subtest: ccs0
[208.589226] Dynamic subtest ccs0: SUCCESS (1.979s)
[208.592244] Subtest engine-engine-error: SUCCESS (11.735s)
[208.680854] [026/131] (809s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[208.797147] Starting subtest: yf-tiled-32bpp-rotate-180
[208.802436] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[208.931922] [027/131] (809s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[209.019621] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[209.024783] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[209.129167] [028/131] (809s left) kms_big_fb (linear-64bpp-rotate-90)
[209.223569] Starting subtest: linear-64bpp-rotate-90
[209.243792] Subtest linear-64bpp-rotate-90: SKIP (0.019s)
[209.383116] [029/131] (808s left) gem_softpin (noreloc-s3)
[209.441601] Starting subtest: noreloc-S3
[229.938606] Subtest noreloc-S3: SUCCESS (5.425s)
[230.124834] [030/131] (788s left) gem_ctx_engines (none)
[230.186073] Starting subtest: none
[230.188567] Subtest none: SUCCESS (0.001s)
[230.380009] [031/131] (787s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[230.770163] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[231.619809] [032/131] (786s left) kms_dsc (dsc-with-output-formats-with-bpc)
[231.715596] Starting subtest: dsc-with-output-formats-with-bpc
[231.776342] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[231.813263] [033/131] (786s left) gen9_exec_parse (shadow-peek)
[231.883127] Subtest shadow-peek: SKIP (0.000s)
[231.975070] [034/131] (786s left) kms_cursor_legacy (cursor-vs-flip-atomic-transitions-varying-size)
[232.094621] Starting subtest: cursor-vs-flip-atomic-transitions-varying-size
[263.588479] Subtest cursor-vs-flip-atomic-transitions-varying-size: SUCCESS (31.397s)
[264.409845] [035/131] (754s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[264.510231] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[264.514282] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[264.656879] [036/131] (753s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0)
[264.763211] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0
[265.798160] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (1.034s)
[265.955344] [037/131] (752s left) api_intel_bb (offset-control)
[266.007232] Starting subtest: offset-control
[266.012937] Subtest offset-control: SUCCESS (0.008s)
[266.185560] [038/131] (752s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[266.283034] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[270.879430] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.598s)
[272.035509] [039/131] (746s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[272.131774] Starting subtest: plane-primary-overlay-mutable-zpos
[275.532550] Subtest plane-primary-overlay-mutable-zpos: SKIP (3.399s)
[276.734040] [040/131] (741s left) perf (global-sseu-config-invalid)
[276.866571] Starting subtest: global-sseu-config-invalid
[276.870262] Subtest global-sseu-config-invalid: SKIP (0.000s)
[276.907487] [041/131] (741s left) gem_basic (create-close)
[276.962053] Starting subtest: create-close
[276.966248] Subtest create-close: SUCCESS (0.000s)
[277.087566] [042/131] (741s left) gem_softpin (full)
[277.145182] Starting subtest: full
[277.149638] Subtest full: SUCCESS (0.007s)
[277.312102] [043/131] (741s left) gem_mmap_gtt (basic-write)
[277.370405] Subtest basic-write: SKIP (0.000s)
[277.427556] [044/131] (741s left) kms_pm_rpm (system-suspend-idle)
[278.939030] Starting subtest: system-suspend-idle
[298.328929] Subtest system-suspend-idle: SUCCESS (4.624s)
[298.698002] [045/131] (720s left) gem_userptr_blits (process-exit-busy)
[298.773927] Starting subtest: process-exit-busy
[298.790241] Subtest process-exit-busy: SUCCESS (0.018s)
[298.964176] [046/131] (719s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-onoff)
[299.064846] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-onoff
[306.237456] Subtest fbcpsr-1p-primscrn-cur-indfb-onoff: SUCCESS (7.091s)
[306.373881] [047/131] (712s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[306.478108] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[306.482269] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SKIP (0.000s)
[306.603570] [048/131] (712s left) kms_cursor_crc (cursor-onscreen-32x10)
[306.763647] Starting subtest: cursor-onscreen-32x10
[306.810990] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[307.062554] [049/131] (711s left) kms_psr (fbc-pr-sprite-render)
[307.153650] Starting subtest: fbc-pr-sprite-render
[307.157816] Subtest fbc-pr-sprite-render: SKIP (0.000s)
[307.237092] [050/131] (711s left) kms_psr (psr-cursor-blt)
[307.328059] Starting subtest: psr-cursor-blt
[307.330061] Starting dynamic subtest: eDP-1
[309.030463] Dynamic subtest eDP-1: SUCCESS (1.692s)
[309.033068] Subtest psr-cursor-blt: SUCCESS (1.693s)
[309.921576] [051/131] (709s left) gem_madvise (dontneed-before-mmap)
[309.956418] Starting subtest: dontneed-before-mmap
[309.980199] Subtest dontneed-before-mmap: SUCCESS (0.025s)
[310.114007] [052/131] (709s left) gem_vm_create (invalid-create)
[310.177712] Starting subtest: invalid-create
[310.180067] Subtest invalid-create: SUCCESS (0.002s)
[310.338805] [053/131] (708s left) gem_pread (display)
[310.390840] Subtest display: SKIP (0.000s)
[310.452894] [054/131] (708s left) gem_set_tiling_vs_blt (tiled-to-untiled)
[310.518561] Subtest tiled-to-untiled: SKIP (0.000s)
[310.614764] [055/131] (708s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-64bpp-yftile-downscaling)
[310.715044] Starting subtest: flip-32bpp-yftile-to-64bpp-yftile-downscaling
[310.717357] Starting dynamic subtest: pipe-A-default-mode
[311.007014] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[311.011391] Subtest flip-32bpp-yftile-to-64bpp-yftile-downscaling: SKIP (0.291s)
[311.860758] [056/131] (707s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[311.961616] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[311.966006] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[312.053710] [057/131] (707s left) perf_pmu (most-busy-idle-check-all)
[312.092660] Starting subtest: most-busy-idle-check-all
[312.094785] Starting dynamic subtest: rcs0
[312.802428] Dynamic subtest rcs0: FAIL (0.648s)
[312.811911] Starting dynamic subtest: bcs0
[313.436975] Dynamic subtest bcs0: FAIL (0.615s)
[313.446953] Starting dynamic subtest: vcs0
[315.323686] Dynamic subtest vcs0: SUCCESS (1.956s)
[315.334953] Starting dynamic subtest: vcs1
[317.309124] Dynamic subtest vcs1: SUCCESS (1.977s)
[317.319325] Starting dynamic subtest: vecs0
[319.356894] Dynamic subtest vecs0: SUCCESS (2.044s)
[319.369641] Starting dynamic subtest: ccs0
[321.341013] Dynamic subtest ccs0: SUCCESS (1.978s)
[321.344499] Subtest most-busy-idle-check-all: FAIL (9.227s)
[321.453394] [058/131] (697s left) gem_exec_balancer (busy)
[321.514271] Starting subtest: busy
[323.350841] Subtest busy: SUCCESS (1.832s)
[323.702487] [059/131] (695s left) kms_prop_blob (invalid-set-prop-any)
[323.751808] Starting subtest: invalid-set-prop-any
[323.753769] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[323.877329] [060/131] (695s left) gem_exec_schedule (submit-early-slice)
[323.946926] Starting subtest: submit-early-slice
[323.949178] Starting dynamic subtest: rcs0
[324.003849] Dynamic subtest rcs0: SUCCESS (0.063s)
[324.021035] Starting dynamic subtest: bcs0
[324.062060] Dynamic subtest bcs0: SUCCESS (0.058s)
[324.073738] Starting dynamic subtest: vcs0
[324.120898] Dynamic subtest vcs0: SUCCESS (0.058s)
[324.130150] Starting dynamic subtest: vcs1
[324.175238] Dynamic subtest vcs1: SUCCESS (0.053s)
[324.186728] Starting dynamic subtest: vecs0
[324.220422] Dynamic subtest vecs0: SUCCESS (0.045s)
[324.229814] Starting dynamic subtest: ccs0
[324.276112] Dynamic subtest ccs0: SUCCESS (0.054s)
[324.278618] Subtest submit-early-slice: SUCCESS (0.336s)
[325.438011] [061/131] (694s left) kms_frontbuffer_tracking (fbc-2p-primscrn-indfb-plflip-blt)
[325.533170] Starting subtest: fbc-2p-primscrn-indfb-plflip-blt
[325.537287] Subtest fbc-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[325.662950] [062/131] (693s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-indfb-draw-render)
[325.765118] Starting subtest: psr-1p-offscreen-pri-indfb-draw-render
[332.739612] Subtest psr-1p-offscreen-pri-indfb-draw-render: SUCCESS (6.977s)
[332.922227] [063/131] (686s left) kms_chamelium_hpd (hdmi-hpd-fast)
[333.316196] Subtest hdmi-hpd-fast: SKIP (0.000s)
[334.104591] [064/131] (685s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[334.201655] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[334.204011] Starting dynamic subtest: A-eDP1
[337.856301] Dynamic subtest A-eDP1: SUCCESS (3.656s)
[337.866846] Starting dynamic subtest: B-eDP1
[341.065386] Dynamic subtest B-eDP1: SUCCESS (3.208s)
[341.075557] Starting dynamic subtest: C-eDP1
[344.179656] Dynamic subtest C-eDP1: SUCCESS (3.110s)
[344.189730] Starting dynamic subtest: D-eDP1
[347.293193] Dynamic subtest D-eDP1: SUCCESS (3.107s)
[347.295219] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.089s)
[348.103007] [065/131] (671s left) kms_flip (bo-too-big)
[348.199189] Starting subtest: bo-too-big
[348.201598] Starting dynamic subtest: A-eDP1
[349.540025] Dynamic subtest A-eDP1: SUCCESS (1.339s)
[349.555192] Starting dynamic subtest: B-eDP1
[350.877145] Dynamic subtest B-eDP1: SUCCESS (1.335s)
[350.887464] Starting dynamic subtest: C-eDP1
[352.221550] Dynamic subtest C-eDP1: SUCCESS (1.343s)
[352.231683] Starting dynamic subtest: D-eDP1
[353.548305] Dynamic subtest D-eDP1: SUCCESS (1.325s)
[353.550781] Subtest bo-too-big: SUCCESS (5.351s)
[354.760448] [066/131] (664s left) kms_cursor_crc (cursor-onscreen-64x21)
[354.944750] Starting subtest: cursor-onscreen-64x21
[354.995733] Subtest cursor-onscreen-64x21: SKIP (0.045s)
[355.234358] [067/131] (664s left) gen7_exec_parse (chained-batch)
[355.294999] Subtest chained-batch: SKIP (0.000s)
[355.365886] [068/131] (664s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[355.453731] Starting subtest: crc-primary-basic-yf-tiled-ccs
[355.456014] Starting dynamic subtest: pipe-A-eDP-1
[355.479520] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[355.490660] Starting dynamic subtest: pipe-B-eDP-1
[355.512416] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[355.521415] Starting dynamic subtest: pipe-C-eDP-1
[355.543043] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[355.552133] Starting dynamic subtest: pipe-D-eDP-1
[355.575424] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[355.579998] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.006s)
[357.639856] [069/131] (662s left) kms_dither (fb-8bpc-vs-panel-8bpc)
[357.723495] Starting subtest: fb-8bpc-vs-panel-8bpc
[357.725876] Starting dynamic subtest: pipe-A-eDP-1
[359.090806] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.368s)
[359.093051] Subtest fb-8bpc-vs-panel-8bpc: SUCCESS (1.369s)
[359.895629] [070/131] (659s left) gem_userptr_blits (stress-mm-invalidate-close)
[359.953889] Starting subtest: stress-mm-invalidate-close
[362.100335] Subtest stress-mm-invalidate-close: SUCCESS (2.148s)
[362.258052] [071/131] (657s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-render)
[362.361058] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-render
[366.543844] Subtest fbc-1p-offscreen-pri-indfb-draw-render: SUCCESS (4.183s)
[367.703657] [072/131] (652s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[367.815644] Starting subtest: extended-pageflip-modeset-hang-oldfb
[367.817886] Starting dynamic subtest: pipe-A
[375.709174] Dynamic subtest pipe-A: SUCCESS (7.888s)
[375.718646] Starting dynamic subtest: pipe-D
[384.285293] Dynamic subtest pipe-D: SUCCESS (8.567s)
[384.287783] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (16.461s)
[385.143461] [073/131] (634s left) kms_psr (fbc-psr-primary-render)
[385.243648] Starting subtest: fbc-psr-primary-render
[385.245875] Starting dynamic subtest: eDP-1
[385.250132] Dynamic subtest eDP-1: SKIP (0.000s)
[385.254389] Subtest fbc-psr-primary-render: SKIP (0.001s)
[385.340910] [074/131] (634s left) syncobj_wait (invalid-reset-zero-handles)
[385.399490] Starting subtest: invalid-reset-zero-handles
[385.401778] Subtest invalid-reset-zero-handles: SUCCESS (0.000s)
[385.521462] [075/131] (634s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[385.613736] Starting subtest: compare-crc-sanitycheck-nv12
[385.615653] Starting dynamic subtest: pipe-A-eDP-1
[386.334289] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.721s)
[386.344011] Starting dynamic subtest: pipe-B-eDP-1
[387.635658] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.300s)
[387.645503] Starting dynamic subtest: pipe-C-eDP-1
[388.925782] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.285s)
[388.936374] Starting dynamic subtest: pipe-D-eDP-1
[390.146366] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.221s)
[390.148886] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.533s)
[390.982324] [076/131] (629s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[391.090567] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[397.941141] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.856s)
[398.052249] [077/131] (622s left) gem_ctx_shared (disjoint-timelines)
[398.128139] Starting subtest: disjoint-timelines
[398.228999] Subtest disjoint-timelines: SUCCESS (0.101s)
[398.468049] [FACT gem_ctx_shared (disjoint-timelines)] new: kernel.kmod_is_loaded.vgem: true
[398.472336] [078/131] (621s left) gem_sync (basic-store-all)
[398.547306] Starting subtest: basic-store-all
[401.710990] Subtest basic-store-all: SUCCESS (3.176s)
[401.908110] [079/131] (618s left) kms_big_fb (x-tiled-32bpp-rotate-270)
[402.014132] Starting subtest: x-tiled-32bpp-rotate-270
[402.037225] Subtest x-tiled-32bpp-rotate-270: SKIP (0.020s)
[402.203771] [080/131] (618s left) gem_busy (parallel)
[402.387657] Starting subtest: parallel
[402.389649] Starting dynamic subtest: rcs0
[404.349176] Dynamic subtest rcs0: SUCCESS (1.962s)
[404.362232] Starting dynamic subtest: bcs0
[406.333529] Dynamic subtest bcs0: SUCCESS (1.981s)
[406.348548] Starting dynamic subtest: vcs0
[408.317362] Dynamic subtest vcs0: SUCCESS (1.981s)
[408.330292] Starting dynamic subtest: vcs1
[410.301314] Dynamic subtest vcs1: SUCCESS (1.981s)
[410.313342] Starting dynamic subtest: vecs0
[412.349760] Dynamic subtest vecs0: SUCCESS (2.046s)
[412.362349] Starting dynamic subtest: ccs0
[414.332993] Dynamic subtest ccs0: SUCCESS (1.980s)
[414.335652] Subtest parallel: SUCCESS (11.949s)
[414.597562] [081/131] (605s left) gem_ctx_param (set-priority-not-supported)
[414.651166] Starting subtest: set-priority-not-supported
[414.655860] Subtest set-priority-not-supported: SKIP (0.000s)
[414.743245] [082/131] (605s left) kms_chamelium_color (gamma)
[414.835777] Subtest gamma: SKIP (0.000s)
[414.882324] [083/131] (605s left) gem_exec_whisper (basic-sync-all)
[414.950596] Starting subtest: basic-sync-all
[421.035987] Subtest basic-sync-all: SUCCESS (6.086s)
[421.241460] [084/131] (599s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[421.316660] Starting subtest: map-fixed-invalidate-overlap-busy
[421.320787] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[421.466144] [085/131] (598s left) gem_pxp (dmabuf-shared-protected-dst-is-context-refcounted)
[421.596624] Starting subtest: dmabuf-shared-protected-dst-is-context-refcounted
[421.732783] Subtest dmabuf-shared-protected-dst-is-context-refcounted: SUCCESS (0.139s)
[421.899999] [086/131] (598s left) kms_cursor_crc (cursor-tearing-position-change)
[422.015852] Starting subtest: cursor-tearing-position-change
[422.018261] Starting dynamic subtest: pipe-A-eDP-1
[422.581655] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.567s)
[422.593649] Starting dynamic subtest: pipe-D-eDP-1
[423.829939] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.245s)
[423.831934] Subtest cursor-tearing-position-change: SUCCESS (1.815s)
[424.675246] [087/131] (595s left) kms_vblank (wait-idle-hang)
[424.759724] Starting subtest: wait-idle-hang
[424.762024] Starting dynamic subtest: pipe-A-eDP-1
[451.065337] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.300s)
[451.079702] Starting dynamic subtest: pipe-D-eDP-1
[476.093326] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.020s)
[476.095244] Subtest wait-idle-hang: SUCCESS (51.324s)
[476.933091] [088/131] (543s left) kms_flip (2x-dpms-vs-vblank-race)
[477.035267] Starting subtest: 2x-dpms-vs-vblank-race
[477.044637] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s)
[477.178774] [089/131] (543s left) gem_ctx_persistence (file)
[477.240765] Starting subtest: file
[477.393215] Subtest file: SUCCESS (0.152s)
[477.532500] [090/131] (543s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-render)
[477.634692] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-render
[477.638825] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[477.750724] [091/131] (542s left) kms_plane_scaling (planes-upscale-factor-0-25-downscale-factor-0-5)
[477.842924] Starting subtest: planes-upscale-factor-0-25-downscale-factor-0-5
[477.844716] Starting dynamic subtest: pipe-A
[477.863817] Dynamic subtest pipe-A: SKIP (0.018s)
[477.873106] Starting dynamic subtest: pipe-B
[477.907217] Dynamic subtest pipe-B: SKIP (0.041s)
[477.916865] Starting dynamic subtest: pipe-C
[477.940853] Dynamic subtest pipe-C: SKIP (0.033s)
[477.949636] Starting dynamic subtest: pipe-D
[477.975323] Dynamic subtest pipe-D: SKIP (0.033s)
[477.978895] Subtest planes-upscale-factor-0-25-downscale-factor-0-5: SKIP (0.131s)
[478.094199] [092/131] (542s left) gem_eio (wait-immediate)
[478.304965] Starting subtest: wait-immediate
[478.657325] Subtest wait-immediate: SUCCESS (0.353s)
[478.811985] [093/131] (541s left) gem_sync (basic-all)
[478.882836] Starting subtest: basic-all
[482.299047] Subtest basic-all: SUCCESS (3.421s)
[482.506898] [094/131] (538s left) kms_joiner (invalid-modeset-ultra-joiner)
[482.624731] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[482.708055] [095/131] (538s left) kms_psr2_sf (psr2-cursor-plane-move-continuous-exceed-sf)
[487.697303] Starting subtest: psr2-cursor-plane-move-continuous-exceed-sf
[487.699741] Starting dynamic subtest: pipe-A-eDP-1
[499.115361] Dynamic subtest pipe-A-eDP-1: SUCCESS (11.412s)
[499.126139] Starting dynamic subtest: pipe-B-eDP-1
[510.559141] Dynamic subtest pipe-B-eDP-1: SUCCESS (11.436s)
[510.561298] Subtest psr2-cursor-plane-move-continuous-exceed-sf: SUCCESS (22.852s)
[511.424598] [096/131] (509s left) gem_exec_reloc (basic-wc-cpu-noreloc)
[511.490181] Subtest basic-wc-cpu-noreloc: SKIP (0.000s)
[511.575113] [097/131] (509s left) gem_exec_schedule (preempt-hang)
[511.759494] Starting subtest: preempt-hang
[511.761747] Starting dynamic subtest: rcs0
[512.004014] Dynamic subtest rcs0: SUCCESS (0.245s)
[512.016459] Starting dynamic subtest: bcs0
[512.240767] Dynamic subtest bcs0: SUCCESS (0.235s)
[512.252824] Starting dynamic subtest: vcs0
[512.470961] Dynamic subtest vcs0: SUCCESS (0.231s)
[512.481757] Starting dynamic subtest: vcs1
[512.708623] Dynamic subtest vcs1: SUCCESS (0.233s)
[512.721015] Starting dynamic subtest: vecs0
[512.942711] Dynamic subtest vecs0: SUCCESS (0.234s)
[512.954846] Starting dynamic subtest: ccs0
[513.185714] Dynamic subtest ccs0: SUCCESS (0.240s)
[513.187809] Subtest preempt-hang: SUCCESS (1.426s)
[513.480508] [098/131] (507s left) gem_exec_fence (keep-in-fence)
[513.663088] Starting subtest: keep-in-fence
[513.665473] Starting dynamic subtest: rcs0
[513.740624] Dynamic subtest rcs0: SUCCESS (0.077s)
[513.753181] Starting dynamic subtest: bcs0
[513.793638] Dynamic subtest bcs0: SUCCESS (0.051s)
[513.807680] Starting dynamic subtest: vcs0
[515.324644] Dynamic subtest vcs0: SUCCESS (1.526s)
[515.337705] Starting dynamic subtest: vcs1
[517.308629] Dynamic subtest vcs1: SUCCESS (1.981s)
[517.321051] Starting dynamic subtest: vecs0
[519.356895] Dynamic subtest vecs0: SUCCESS (2.045s)
[519.369046] Starting dynamic subtest: ccs0
[519.600352] Dynamic subtest ccs0: SUCCESS (0.242s)
[519.603054] Subtest keep-in-fence: SUCCESS (5.937s)
[521.467548] [099/131] (499s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[521.532093] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[521.534372] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[521.641448] [100/131] (499s left) kms_psr (fbc-pr-basic)
[521.730718] Starting subtest: fbc-pr-basic
[521.735067] Subtest fbc-pr-basic: SKIP (0.000s)
[521.826216] [101/131] (499s left) kms_ccs (random-ccs-data-4-tiled-bmg-ccs)
[521.919777] Starting subtest: random-ccs-data-4-tiled-bmg-ccs
[521.924616] Subtest random-ccs-data-4-tiled-bmg-ccs: SKIP (0.000s)
[523.066023] [102/131] (498s left) kms_rotation_crc (cursor-rotation-180)
[523.166432] Starting subtest: cursor-rotation-180
[524.609663] Subtest cursor-rotation-180: SUCCESS (1.445s)
[525.810964] [103/131] (495s left) sw_sync (sync_merge_same)
[525.847815] Starting subtest: sync_merge_same
[525.850102] Subtest sync_merge_same: SUCCESS (0.000s)
[525.932857] [104/131] (495s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-move)
[526.031203] Starting subtest: fbc-2p-primscrn-cur-indfb-move
[526.035163] Subtest fbc-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[526.160653] [105/131] (495s left) kms_selftest (drm_framebuffer)
[526.190316] Starting subtest: drm_framebuffer
[526.203006] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[526.330992] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.128s)
[526.340934] Starting dynamic subtest: drm_test_framebuffer_cleanup
[526.459664] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.129s)
[526.469845] Starting dynamic subtest: drm_test_framebuffer_create
[526.677397] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.215s)
[526.692895] Starting dynamic subtest: drm_test_framebuffer_free
[526.910659] Dynamic subtest drm_test_framebuffer_free: FAIL (0.172s)
[526.914974] Subtest drm_framebuffer: FAIL (0.661s)
[527.027537] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[527.045176] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[527.046071] Closing watchdogs
results: parsing output: 0/ for test: gem_render_copy
results: parsing output: 1/ for test: gem_exec_whisper
results: parsing output: 2/ for test: gem_exec_balancer
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: gem_ctx_exec
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_content_protection
results: parsing output: 7/ for test: kms_pipe_b_c_ivb
results: parsing output: 8/ for test: gem_mmap_offset
results: parsing output: 9/ for test: syncobj_timeline
results: parsing output: 10/ for test: kms_flip
results: parsing output: 11/ for test: syncobj_basic
results: parsing output: 12/ for test: syncobj_wait
results: parsing output: 13/ for test: dumb_buffer
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_rotation_crc
results: parsing output: 17/ for test: kms_pm_rpm
results: parsing output: 18/ for test: kms_plane_scaling
results: parsing output: 19/ for test: syncobj_wait
results: parsing output: 20/ for test: i915_pm_rps
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_mmap_wc
results: parsing output: 23/ for test: syncobj_timeline
results: parsing output: 24/ for test: i915_hangman
results: parsing output: 25/ for test: kms_big_fb
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: gem_softpin
results: parsing output: 29/ for test: gem_ctx_engines
results: parsing output: 30/ for test: kms_chamelium_edid
results: parsing output: 31/ for test: kms_dsc
results: parsing output: 32/ for test: gen9_exec_parse
results: parsing output: 33/ for test: kms_cursor_legacy
results: parsing output: 34/ for test: kms_frontbuffer_tracking
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: api_intel_bb
results: parsing output: 37/ for test: kms_frontbuffer_tracking
results: parsing output: 38/ for test: kms_atomic
results: parsing output: 39/ for test: perf
results: parsing output: 40/ for test: gem_basic
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: gem_mmap_gtt
results: parsing output: 43/ for test: kms_pm_rpm
results: parsing output: 44/ for test: gem_userptr_blits
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_big_fb
results: parsing output: 47/ for test: kms_cursor_crc
results: parsing output: 48/ for test: kms_psr
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: gem_madvise
results: parsing output: 51/ for test: gem_vm_create
results: parsing output: 52/ for test: gem_pread
results: parsing output: 53/ for test: gem_set_tiling_vs_blt
results: parsing output: 54/ for test: kms_flip_scaled_crc
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_exec_balancer
results: parsing output: 58/ for test: kms_prop_blob
results: parsing output: 59/ for test: gem_exec_schedule
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_chamelium_hpd
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_flip
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: gen7_exec_parse
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: kms_dither
results: parsing output: 69/ for test: gem_userptr_blits
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: kms_busy
results: parsing output: 72/ for test: kms_psr
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: kms_pipe_crc_basic
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: gem_ctx_shared
results: parsing output: 77/ for test: gem_sync
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: gem_busy
results: parsing output: 80/ for test: gem_ctx_param
results: parsing output: 81/ for test: kms_chamelium_color
results: parsing output: 82/ for test: gem_exec_whisper
results: parsing output: 83/ for test: gem_userptr_blits
results: parsing output: 84/ for test: gem_pxp
results: parsing output: 85/ for test: kms_cursor_crc
results: parsing output: 86/ for test: kms_vblank
results: parsing output: 87/ for test: kms_flip
results: parsing output: 88/ for test: gem_ctx_persistence
results: parsing output: 89/ for test: kms_frontbuffer_tracking
results: parsing output: 90/ for test: kms_plane_scaling
results: parsing output: 91/ for test: gem_eio
results: parsing output: 92/ for test: gem_sync
results: parsing output: 93/ for test: kms_joiner
results: parsing output: 94/ for test: kms_psr2_sf
results: parsing output: 95/ for test: gem_exec_reloc
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: gem_exec_fence
results: parsing output: 98/ for test: syncobj_timeline
results: parsing output: 99/ for test: kms_psr
results: parsing output: 100/ for test: kms_ccs
results: parsing output: 101/ for test: kms_rotation_crc
results: parsing output: 102/ for test: sw_sync
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: kms_selftest
results: parsing output: 105/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 106/ for test: gem_ctx_isolation
results: no output, setting notrun
results: parsing output: 107/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 108/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 109/ for test: kms_scaling_modes
results: no output, setting notrun
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 111/ for test: gem_create
results: no output, setting notrun
results: parsing output: 112/ for test: kms_invalid_mode
results: no output, setting notrun
results: parsing output: 113/ for test: vgem_basic
results: no output, setting notrun
results: parsing output: 114/ for test: api_intel_allocator
results: no output, setting notrun
results: parsing output: 115/ for test: prime_mmap
results: no output, setting notrun
results: parsing output: 116/ for test: kms_plane_cursor
results: no output, setting notrun
results: parsing output: 117/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 118/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 119/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 120/ for test: sriov_basic
results: no output, setting notrun
results: parsing output: 121/ for test: kms_addfb_basic
results: no output, setting notrun
results: parsing output: 122/ for test: gem_exec_reloc
results: no output, setting notrun
results: parsing output: 123/ for test: i915_query
results: no output, setting notrun
results: parsing output: 124/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 125/ for test: gem_render_copy
results: no output, setting notrun
results: parsing output: 126/ for test: syncobj_wait
results: no output, setting notrun
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 128/ for test: kms_big_fb
results: no output, setting notrun
results: parsing output: 129/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 130/ for test: kms_flip
results: no output, setting notrun
Done.