[57.450406] Initializing watchdogs
[57.450456]   /dev/watchdog0
[57.465243] [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]
[57.469970] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[57.472301] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[57.475722] [001/133] (960s left) syncobj_timeline (multi-wait-all-signaled)
[57.559463] Starting subtest: multi-wait-all-signaled
[57.561823] Subtest multi-wait-all-signaled: SUCCESS (0.001s)
[57.677129] [002/133] (960s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move)
[57.775262] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move
[57.779290] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s)
[57.880902] [003/133] (960s left) gem_ctx_param (set-priority-range)
[57.929837] Starting subtest: set-priority-range
[57.944888] Subtest set-priority-range: SUCCESS (0.015s)
[58.051564] [004/133] (960s left) gem_pxp (regular-baseline-src-copy-readible)
[58.200019] Starting subtest: regular-baseline-src-copy-readible
[58.258436] Subtest regular-baseline-src-copy-readible: SUCCESS (0.062s)
[58.378590] [005/133] (959s left) kms_atomic_interruptible (legacy-dpms)
[58.472965] Starting subtest: legacy-dpms
[58.475046] Starting dynamic subtest: pipe-A-eDP-1
[65.888282] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.457s)
[65.890610] Subtest legacy-dpms: SUCCESS (7.458s)
[66.687355] [006/133] (951s left) kms_big_fb (linear-8bpp-rotate-270)
[66.815674] Starting subtest: linear-8bpp-rotate-270
[66.836592] Subtest linear-8bpp-rotate-270: SKIP (0.021s)
[66.965610] [007/133] (951s left) perf_pmu (render-node-busy)
[67.334654] Starting subtest: render-node-busy
[67.337338] Starting dynamic subtest: rcs0
[68.261680] Dynamic subtest rcs0: SUCCESS (0.931s)
[68.271773] Starting dynamic subtest: bcs0
[68.822948] Dynamic subtest bcs0: SUCCESS (0.562s)
[68.833490] Starting dynamic subtest: vcs0
[70.933963] Dynamic subtest vcs0: SUCCESS (2.112s)
[70.944889] Starting dynamic subtest: vcs1
[72.919855] Dynamic subtest vcs1: SUCCESS (1.987s)
[72.931545] Starting dynamic subtest: vecs0
[74.902485] Dynamic subtest vecs0: SUCCESS (1.983s)
[74.913280] Starting dynamic subtest: ccs0
[75.467101] Dynamic subtest ccs0: SUCCESS (0.565s)
[75.469904] Subtest render-node-busy: SUCCESS (8.148s)
[75.540647] [008/133] (942s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping)
[75.640700] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping
[75.645580] Subtest pixel-format-y-tiled-gen12-rc-ccs-cc-modifier-source-clamping: SKIP (0.000s)
[75.714176] [009/133] (942s left) gem_ctx_isolation (dirty-create)
[75.776104] Starting subtest: dirty-create
[75.778310] Starting dynamic subtest: rcs0
[75.973922] Dynamic subtest rcs0: SUCCESS (0.201s)
[75.984014] Starting dynamic subtest: bcs0
[76.187677] Dynamic subtest bcs0: SUCCESS (0.213s)
[76.195767] Starting dynamic subtest: vcs0
[76.380624] Dynamic subtest vcs0: SUCCESS (0.192s)
[76.389373] Starting dynamic subtest: vcs1
[78.096590] Dynamic subtest vcs1: SUCCESS (1.717s)
[78.105950] Starting dynamic subtest: vecs0
[80.095120] Dynamic subtest vecs0: SUCCESS (1.998s)
[80.104864] Starting dynamic subtest: ccs0
[82.106148] Dynamic subtest ccs0: SUCCESS (2.010s)
[82.108610] Subtest dirty-create: SUCCESS (6.334s)
[82.352377] [010/133] (935s left) gem_exec_balancer (full-late)
[82.432694] Starting subtest: full-late
[86.731814] Subtest full-late: SUCCESS (4.299s)
[87.050219] [011/133] (931s left) kms_plane (pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping)
[87.144839] Starting subtest: pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping
[87.149268] Subtest pixel-format-y-tiled-gen12-rc-ccs-modifier-source-clamping: SKIP (0.000s)
[87.245308] [012/133] (931s left) gem_mmap_gtt (flink-race)
[87.317545] Subtest flink-race: SKIP (0.000s)
[87.410242] [013/133] (931s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180)
[87.519316] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180
[87.523661] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180: SKIP (0.000s)
[87.608699] [014/133] (930s left) kms_lease (lease-get)
[87.712042] Starting subtest: lease-get
[87.714458] Starting dynamic subtest: pipe-A-eDP-1
[87.716833] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[87.724713] Starting dynamic subtest: pipe-B-eDP-1
[87.726682] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[87.733818] Starting dynamic subtest: pipe-C-eDP-1
[87.735782] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[87.743127] Starting dynamic subtest: pipe-D-eDP-1
[87.745061] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[87.746923] Subtest lease-get: SUCCESS (0.008s)
[87.822522] [015/133] (930s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-render)
[87.923796] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-render
[87.928197] Subtest fbc-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[88.002846] [016/133] (930s left) kms_flip_event_leak (basic)
[88.087333] Starting subtest: basic
[88.089232] Starting dynamic subtest: pipe-A-eDP-1
[88.513173] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.424s)
[88.522142] Starting dynamic subtest: pipe-B-eDP-1
[89.598781] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.087s)
[89.607676] Starting dynamic subtest: pipe-C-eDP-1
[90.703239] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.104s)
[90.712356] Starting dynamic subtest: pipe-D-eDP-1
[91.853170] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.147s)
[91.855519] Subtest basic: SUCCESS (3.765s)
[92.689405] [017/133] (925s left) gem_exec_reloc (basic-cpu-read-noreloc)
[92.747912] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[92.823772] [018/133] (925s left) kms_chamelium_audio (hdmi-audio-edid)
[93.202201] Subtest hdmi-audio-edid: SKIP (0.000s)
[94.010104] [019/133] (924s left) kms_invalid_mode (overflow-vrefresh)
[94.119382] Starting subtest: overflow-vrefresh
[94.121775] Starting dynamic subtest: pipe-A-eDP-1
[94.420214] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.302s)
[94.428732] Starting dynamic subtest: pipe-B-eDP-1
[94.430683] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[94.437425] Starting dynamic subtest: pipe-C-eDP-1
[94.439411] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[94.446787] Starting dynamic subtest: pipe-D-eDP-1
[94.449113] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[94.451610] Subtest overflow-vrefresh: SUCCESS (0.307s)
[95.263293] [020/133] (923s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[95.368780] Starting subtest: yf-tiled-32bpp-rotate-180
[95.373406] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[95.464108] [021/133] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu)
[95.566233] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu
[102.281756] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (6.716s)
[102.456799] [022/133] (916s left) kms_plane_cursor (overlay)
[102.558951] Starting subtest: overlay
[102.563398] Starting dynamic subtest: pipe-A-eDP-1-size-64
[105.112554] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.554s)
[105.170269] Starting dynamic subtest: pipe-A-eDP-1-size-128
[107.791842] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.627s)
[107.851910] Starting dynamic subtest: pipe-A-eDP-1-size-256
[110.382364] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.538s)
[110.742423] Starting dynamic subtest: pipe-B-eDP-1-size-64
[114.007936] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.275s)
[114.066741] Starting dynamic subtest: pipe-B-eDP-1-size-128
[116.575692] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.515s)
[116.637400] Starting dynamic subtest: pipe-B-eDP-1-size-256
[119.176692] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.549s)
[119.524808] Starting dynamic subtest: pipe-C-eDP-1-size-64
[122.409735] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.894s)
[122.446491] Starting dynamic subtest: pipe-C-eDP-1-size-128
[124.598133] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.158s)
[124.634625] Starting dynamic subtest: pipe-C-eDP-1-size-256
[126.798440] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.169s)
[127.124577] Starting dynamic subtest: pipe-D-eDP-1-size-64
[130.026329] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.910s)
[130.063827] Starting dynamic subtest: pipe-D-eDP-1-size-128
[132.239652] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.180s)
[132.275351] Starting dynamic subtest: pipe-D-eDP-1-size-256
[134.426111] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.158s)
[134.745445] Subtest overlay: SUCCESS (32.188s)
[135.615312] [023/133] (883s left) kms_cursor_crc (cursor-rapid-movement-32x32)
[135.770798] Starting subtest: cursor-rapid-movement-32x32
[135.817097] Subtest cursor-rapid-movement-32x32: SKIP (0.045s)
[136.137608] [024/133] (882s left) kms_cursor_crc (cursor-offscreen-128x128)
[136.349923] Starting subtest: cursor-offscreen-128x128
[136.354845] Starting dynamic subtest: pipe-A-eDP-1
[138.300398] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.944s)
[138.328398] Starting dynamic subtest: pipe-D-eDP-1
[140.933996] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.612s)
[140.936323] Subtest cursor-offscreen-128x128: SUCCESS (4.583s)
[141.784411] [025/133] (877s left) kms_prime (basic-modeset-hybrid)
[141.863983] Subtest basic-modeset-hybrid: SKIP (0.000s)
[142.002741] [FACT kms_prime (basic-modeset-hybrid)] new: kernel.kmod_is_loaded.vgem: true
[142.006157] [026/133] (877s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[142.110312] Starting subtest: drrs-dirtyfb-ioctl
[142.123259] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[142.220683] [027/133] (876s left) kms_color_pipeline (plane-lut1d-lut1d)
[142.313048] Starting subtest: plane-lut1d-lut1d
[142.459043] Starting dynamic subtest: pipe-A-plane-0
[142.625311] Dynamic subtest pipe-A-plane-0: SUCCESS (0.167s)
[142.635632] Starting dynamic subtest: pipe-A-plane-1
[142.814219] Dynamic subtest pipe-A-plane-1: SUCCESS (0.188s)
[142.821782] Starting dynamic subtest: pipe-A-plane-2
[142.970809] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[144.201068] Starting dynamic subtest: pipe-B-plane-0
[144.394990] Dynamic subtest pipe-B-plane-0: SUCCESS (0.200s)
[144.403180] Starting dynamic subtest: pipe-B-plane-1
[144.562120] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s)
[144.570028] Starting dynamic subtest: pipe-B-plane-2
[144.728751] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s)
[145.894437] Starting dynamic subtest: pipe-C-plane-0
[146.022337] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[146.035614] Starting dynamic subtest: pipe-C-plane-1
[146.177516] Dynamic subtest pipe-C-plane-1: SUCCESS (0.154s)
[146.185142] Starting dynamic subtest: pipe-C-plane-2
[146.332719] Dynamic subtest pipe-C-plane-2: SUCCESS (0.155s)
[147.541051] Starting dynamic subtest: pipe-D-plane-0
[147.699208] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s)
[147.708889] Starting dynamic subtest: pipe-D-plane-1
[147.866044] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[147.874279] Starting dynamic subtest: pipe-D-plane-2
[148.021439] Dynamic subtest pipe-D-plane-2: SUCCESS (0.155s)
[148.310135] Subtest plane-lut1d-lut1d: SUCCESS (5.996s)
[149.118852] [028/133] (870s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[149.228451] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[149.230702] Starting dynamic subtest: pipe-A-eDP-1
[155.093663] Dynamic subtest pipe-A-eDP-1: SUCCESS (5.867s)
[155.102297] Starting dynamic subtest: pipe-B-eDP-1
[161.721435] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.626s)
[161.723814] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (12.496s)
[162.597753] [029/133] (856s left) gem_ctx_param (non-root-set)
[162.653653] Starting subtest: non-root-set
[162.671217] Subtest non-root-set: SUCCESS (0.017s)
[162.780764] [030/133] (856s left) kms_psr2_sf (fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf)
[162.886569] Starting subtest: fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf
[162.888814] Starting dynamic subtest: pipe-A-eDP-1
[162.972256] Dynamic subtest pipe-A-eDP-1: SKIP (0.089s)
[162.982953] Starting dynamic subtest: pipe-B-eDP-1
[164.082615] Dynamic subtest pipe-B-eDP-1: SKIP (1.109s)
[164.087059] Subtest fbc-psr2-overlay-plane-move-continuous-exceed-fully-sf: SKIP (1.200s)
[165.261380] [031/133] (854s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[165.360066] Starting subtest: x-tiled-16bpp-rotate-0
[166.629171] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.268s)
[166.750873] [032/133] (852s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite)
[166.855802] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite
[166.860094] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s)
[166.982981] [033/133] (852s left) vgem_basic (mmap)
[167.037795] Starting subtest: mmap
[167.048507] Subtest mmap: SUCCESS (0.012s)
[167.117505] [034/133] (852s left) kms_flip (2x-flip-vs-expired-vblank)
[167.206395] Starting subtest: 2x-flip-vs-expired-vblank
[167.217515] Subtest 2x-flip-vs-expired-vblank: SKIP (0.010s)
[167.294382] [035/133] (852s left) gem_exec_schedule (preempt-queue-contexts)
[167.368070] Subtest preempt-queue-contexts: SKIP (0.000s)
[167.665122] [036/133] (851s left) gem_caching (read-writes)
[167.730847] Subtest read-writes: SKIP (0.000s)
[167.804636] [037/133] (851s left) gem_userptr_blits (relocations)
[167.872212] Starting subtest: relocations
[167.876675] Subtest relocations: SKIP (0.001s)
[168.022908] [038/133] (851s left) kms_big_fb (4-tiled-addfb)
[168.130070] Starting subtest: 4-tiled-addfb
[168.132286] Subtest 4-tiled-addfb: SUCCESS (0.000s)
[168.245203] [039/133] (851s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs)
[168.336207] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-mc-ccs
[168.338540] Starting dynamic subtest: pipe-A-eDP-1
[170.548958] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.214s)
[170.556689] Starting dynamic subtest: pipe-B-eDP-1
[173.007457] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.456s)
[173.015507] Starting dynamic subtest: pipe-C-eDP-1
[175.156261] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.149s)
[175.164564] Starting dynamic subtest: pipe-D-eDP-1
[177.294176] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.136s)
[177.295958] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SUCCESS (8.961s)
[178.502737] [040/133] (841s left) kms_pm_rpm (basic-rte)
[178.550026] Starting subtest: basic-rte
[181.620930] Subtest basic-rte: SUCCESS (3.070s)
[183.430044] [041/133] (836s left) kms_flip (flip-vs-absolute-wf_vblank)
[183.527806] Starting subtest: flip-vs-absolute-wf_vblank
[183.530137] Starting dynamic subtest: A-eDP1
[192.466895] Dynamic subtest A-eDP1: SUCCESS (8.941s)
[192.475153] Starting dynamic subtest: B-eDP1
[201.395615] Dynamic subtest B-eDP1: SUCCESS (8.927s)
[201.403090] Starting dynamic subtest: C-eDP1
[210.313664] Dynamic subtest C-eDP1: SUCCESS (8.914s)
[210.322802] Starting dynamic subtest: D-eDP1
[219.250891] Dynamic subtest D-eDP1: SUCCESS (8.935s)
[219.253128] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.727s)
[220.480490] [042/133] (799s left) i915_pm_rps (min-max-config-idle)
[220.547882] Starting subtest: min-max-config-idle
[220.552779] Subtest min-max-config-idle: SKIP (0.001s)
[220.656424] [043/133] (799s left) kms_addfb_basic (addfb25-4-tiled)
[220.759094] Starting subtest: addfb25-4-tiled
[220.760934] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[220.867428] [044/133] (798s left) i915_query (engine-info-invalid)
[220.912206] Starting subtest: engine-info-invalid
[220.914479] Subtest engine-info-invalid: SUCCESS (0.000s)
[221.049591] [045/133] (798s left) perf (per-context-mode-unprivileged)
[221.190202] Starting subtest: per-context-mode-unprivileged
[221.193838] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[221.231566] [046/133] (798s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[221.292255] Starting subtest: yf-tiled-to-vebox-x-tiled
[221.296747] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[221.478715] [047/133] (798s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-upscaling)
[221.576093] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-upscaling
[221.580073] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-upscaling: SKIP (0.000s)
[221.647765] [048/133] (798s left) kms_big_fb (y-tiled-64bpp-rotate-0)
[221.741912] Starting subtest: y-tiled-64bpp-rotate-0
[221.746294] Subtest y-tiled-64bpp-rotate-0: SKIP (0.000s)
[221.847786] [049/133] (798s left) kms_hdmi_inject (inject-audio)
[222.203765] Starting subtest: inject-audio
[222.480286] Subtest inject-audio: SUCCESS (0.278s)
[223.039917] [050/133] (797s left) perf_pmu (busy-double-start)
[223.088901] Starting subtest: busy-double-start
[223.090925] Starting dynamic subtest: rcs0
[226.721637] Dynamic subtest rcs0: FAIL (3.578s)
[226.730870] Starting dynamic subtest: bcs0
[230.249700] Dynamic subtest bcs0: SUCCESS (3.584s)
[230.259544] Starting dynamic subtest: vcs0
[234.388070] Dynamic subtest vcs0: SUCCESS (4.136s)
[234.404792] Starting dynamic subtest: vcs1
[238.381999] Dynamic subtest vcs1: SUCCESS (3.991s)
[238.398820] Starting dynamic subtest: vecs0
[242.411983] Dynamic subtest vecs0: SUCCESS (4.027s)
[242.428804] Starting dynamic subtest: ccs0
[246.060044] Dynamic subtest ccs0: FAIL (3.576s)
[246.062455] Subtest busy-double-start: FAIL (22.905s)
[246.119639] [051/133] (774s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[246.176035] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[246.282238] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.106s)
[246.360281] [052/133] (773s left) gem_exec_balancer (parallel-keep-submit-fence)
[246.617059] Starting subtest: parallel-keep-submit-fence
[247.678370] Subtest parallel-keep-submit-fence: SUCCESS (1.061s)
[247.784227] [053/133] (772s left) api_intel_allocator (reserve-simple)
[247.847683] Starting subtest: reserve-simple
[247.851189] Subtest reserve-simple: SUCCESS (0.006s)
[247.971839] [054/133] (772s left) sysfs_timeslice_duration (duration)
[248.029437] Starting subtest: duration
[248.031783] Starting dynamic subtest: vecs0
[261.812425] Dynamic subtest vecs0: SUCCESS (13.780s)
[261.823957] Starting dynamic subtest: ccs0
[274.950046] Dynamic subtest ccs0: SUCCESS (13.136s)
[274.961738] Starting dynamic subtest: vcs0
[288.820407] Dynamic subtest vcs0: SUCCESS (13.865s)
[288.832714] Starting dynamic subtest: bcs0
[301.965171] Dynamic subtest bcs0: SUCCESS (13.143s)
[301.975566] Starting dynamic subtest: rcs0
[315.121775] Dynamic subtest rcs0: SUCCESS (13.152s)
[315.134949] Starting dynamic subtest: vcs1
[328.820753] Dynamic subtest vcs1: SUCCESS (13.694s)
[328.823600] Subtest duration: SUCCESS (80.786s)
[328.895145] [055/133] (691s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[328.998232] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[329.002068] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SKIP (0.000s)
[329.097280] [056/133] (691s left) kms_psr (fbc-psr-sprite-plane-move)
[329.193331] Starting subtest: fbc-psr-sprite-plane-move
[329.195486] Starting dynamic subtest: eDP-1
[329.199650] Dynamic subtest eDP-1: SKIP (0.000s)
[329.203844] Subtest fbc-psr-sprite-plane-move: SKIP (0.001s)
[329.264778] [057/133] (691s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[329.362115] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[329.366067] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[329.479643] [058/133] (690s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[329.535553] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[329.537498] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[329.616636] [059/133] (690s left) gem_ctx_shared (exec-single-timeline)
[329.677297] Starting subtest: exec-single-timeline
[329.679204] Starting dynamic subtest: rcs0
[330.737844] Dynamic subtest rcs0: SUCCESS (1.061s)
[330.750501] Starting dynamic subtest: bcs0
[331.825859] Dynamic subtest bcs0: SUCCESS (1.084s)
[331.836301] Starting dynamic subtest: vcs0
[332.917882] Dynamic subtest vcs0: SUCCESS (1.088s)
[332.926685] Starting dynamic subtest: vcs1
[334.003777] Dynamic subtest vcs1: SUCCESS (1.083s)
[334.014623] Starting dynamic subtest: vecs0
[335.090870] Dynamic subtest vecs0: SUCCESS (1.084s)
[335.102219] Starting dynamic subtest: ccs0
[336.178522] Dynamic subtest ccs0: SUCCESS (1.085s)
[336.181239] Subtest exec-single-timeline: SUCCESS (6.504s)
[336.907130] [060/133] (683s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-cpu)
[337.017365] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-cpu
[337.021591] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s)
[337.140539] [061/133] (683s left) gem_exec_reloc (basic-wc-cpu)
[337.199191] Subtest basic-wc-cpu: SKIP (0.000s)
[337.270012] [062/133] (683s left) kms_content_protection (dp-mst-type-0)
[337.405947] Starting subtest: dp-mst-type-0
[337.410375] Subtest dp-mst-type-0: SKIP (0.000s)
[337.527096] [063/133] (683s left) gem_set_tiling_vs_blt (tiled-to-tiled)
[337.592617] Subtest tiled-to-tiled: SKIP (0.000s)
[337.673477] [064/133] (683s left) kms_cursor_legacy (cursora-vs-flipa-varying-size)
[337.799327] Starting subtest: cursorA-vs-flipA-varying-size
[348.949935] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.151s)
[349.802041] [065/133] (670s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[349.912677] Starting subtest: plane-upscale-20x20-with-pixel-format
[349.915100] Starting dynamic subtest: pipe-A
[350.960255] Dynamic subtest pipe-A: SUCCESS (1.050s)
[350.968142] Starting dynamic subtest: pipe-B
[353.089056] Dynamic subtest pipe-B: SUCCESS (2.128s)
[353.097354] Starting dynamic subtest: pipe-C
[354.239487] Dynamic subtest pipe-C: SUCCESS (1.149s)
[354.247975] Starting dynamic subtest: pipe-D
[355.431837] Dynamic subtest pipe-D: SUCCESS (1.192s)
[355.434194] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.523s)
[356.602632] [066/133] (664s left) gem_exec_schedule (u-fairslice)
[356.687577] Starting subtest: u-fairslice
[356.689596] Starting dynamic subtest: rcs0
[358.699804] Dynamic subtest rcs0: SUCCESS (2.020s)
[358.709127] Starting dynamic subtest: bcs0
[360.718563] Dynamic subtest bcs0: SUCCESS (2.018s)
[360.727596] Starting dynamic subtest: vcs0
[362.740628] Dynamic subtest vcs0: SUCCESS (2.021s)
[362.749090] Starting dynamic subtest: vcs1
[364.759358] Dynamic subtest vcs1: SUCCESS (2.019s)
[364.768301] Starting dynamic subtest: vecs0
[366.780142] Dynamic subtest vecs0: SUCCESS (2.018s)
[366.788847] Starting dynamic subtest: ccs0
[368.800785] Dynamic subtest ccs0: SUCCESS (2.020s)
[368.803045] Subtest u-fairslice: SUCCESS (12.121s)
[369.114687] [067/133] (651s left) gem_close_race (multigpu-basic-threads)
[369.186843] Starting subtest: multigpu-basic-threads
[369.191620] Subtest multigpu-basic-threads: SKIP (0.000s)
[369.418131] [068/133] (651s left) kms_getfb (getfb2-handle-zero)
[369.506902] Starting subtest: getfb2-handle-zero
[369.509084] Subtest getfb2-handle-zero: SUCCESS (0.000s)
[369.597210] [069/133] (651s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-mmap-wc)
[369.698050] Starting subtest: psr-1p-primscrn-cur-indfb-draw-mmap-wc
[376.150948] Subtest psr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.456s)
[376.275229] [070/133] (644s left) kms_chamelium_hpd (dp-hpd-storm)
[376.669423] Subtest dp-hpd-storm: SKIP (0.000s)
[377.476395] [071/133] (643s left) kms_vblank (query-forked-busy)
[377.580949] Starting subtest: query-forked-busy
[377.582962] Starting dynamic subtest: pipe-A-eDP-1
[379.471697] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.890s)
[379.486242] Starting dynamic subtest: pipe-D-eDP-1
[382.029717] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.557s)
[382.032163] Subtest query-forked-busy: SUCCESS (4.451s)
[382.899552] [072/133] (638s left) kms_prop_blob (blob-prop-validate)
[382.958333] Starting subtest: blob-prop-validate
[382.960272] Subtest blob-prop-validate: SUCCESS (0.000s)
[383.077484] [073/133] (637s left) kms_flip (flip-vs-panning-vs-hang)
[383.175304] Starting subtest: flip-vs-panning-vs-hang
[383.177687] Starting dynamic subtest: A-eDP1
[434.369195] Dynamic subtest A-eDP1: SUCCESS (51.192s)
[434.377679] Starting dynamic subtest: D-eDP1
[474.367763] Dynamic subtest D-eDP1: SUCCESS (39.995s)
[474.373683] Subtest flip-vs-panning-vs-hang: SUCCESS (91.194s)
[475.591386] [074/133] (545s left) kms_cursor_crc (cursor-sliding-64x21)
[475.797289] Starting subtest: cursor-sliding-64x21
[475.852102] Subtest cursor-sliding-64x21: SKIP (0.049s)
[476.098302] [075/133] (545s left) gem_exec_flush (basic-wb-ro-default)
[476.169070] Starting subtest: basic-wb-ro-default
[481.621621] Subtest basic-wb-ro-default: SUCCESS (5.453s)
[481.813941] [076/133] (539s left) kms_psr (psr2-cursor-blt)
[481.908260] Starting subtest: psr2-cursor-blt
[481.910676] Starting dynamic subtest: eDP-1
[483.636125] Dynamic subtest eDP-1: SUCCESS (1.726s)
[483.638000] Subtest psr2-cursor-blt: SUCCESS (1.727s)
[484.497991] [077/133] (536s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt)
[484.605471] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt
[484.609572] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[484.708014] [078/133] (536s left) kms_chamelium_frames (dp-crc-fast)
[485.088064] Subtest dp-crc-fast: SKIP (0.000s)
[485.868058] [079/133] (535s left) gem_ctx_persistence (smoketest)
[485.937647] Starting subtest: smoketest
[525.812876] Subtest smoketest: SUCCESS (39.871s)
[525.893694] [080/133] (495s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt)
[526.000260] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt
[526.004582] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[526.098556] [081/133] (495s left) gem_softpin (full)
[526.153323] Starting subtest: full
[526.160920] Subtest full: SUCCESS (0.008s)
[526.266448] [082/133] (495s left) kms_rotation_crc (primary-x-tiled-reflect-x-0)
[526.357373] Starting subtest: primary-x-tiled-reflect-x-0
[533.289049] Subtest primary-x-tiled-reflect-x-0: SUCCESS (6.933s)
[534.486957] [083/133] (486s left) kms_properties (plane-properties-atomic)
[534.580990] Starting subtest: plane-properties-atomic
[534.583214] Starting dynamic subtest: pipe-A-eDP-1
[535.150768] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.569s)
[535.160059] Starting dynamic subtest: pipe-B-eDP-1
[536.423944] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.273s)
[536.432670] Starting dynamic subtest: pipe-C-eDP-1
[537.721500] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.296s)
[537.733312] Starting dynamic subtest: pipe-D-eDP-1
[539.035436] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.314s)
[539.037809] Subtest plane-properties-atomic: SUCCESS (4.457s)
[539.894373] [084/133] (481s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytile-upscaling)
[539.985966] Starting subtest: flip-64bpp-ytile-to-32bpp-ytile-upscaling
[539.990077] Subtest flip-64bpp-ytile-to-32bpp-ytile-upscaling: SKIP (0.000s)
[540.056528] [085/133] (481s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-blt)
[540.148675] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-blt
[540.153120] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[540.251068] [086/133] (481s left) kms_selftest (drm_framebuffer)
[540.288485] Starting subtest: drm_framebuffer
[540.335522] Starting dynamic subtest: drm_test_framebuffer_check_src_coords
[540.438761] Dynamic subtest drm_test_framebuffer_check_src_coords: SUCCESS (0.106s)
[540.447235] Starting dynamic subtest: drm_test_framebuffer_cleanup
[540.562627] Dynamic subtest drm_test_framebuffer_cleanup: SUCCESS (0.119s)
[540.572204] Starting dynamic subtest: drm_test_framebuffer_create
[540.766892] Dynamic subtest drm_test_framebuffer_create: SUCCESS (0.204s)
[540.775558] Starting dynamic subtest: drm_test_framebuffer_free
[540.988230] Dynamic subtest drm_test_framebuffer_free: FAIL (0.163s)
[540.992566] Subtest drm_framebuffer: FAIL (0.643s)
[541.097225] Aborting: Kernel badly tainted (0x44244, 0x200) (check dmesg for details):
	TAINT_WARN: WARN_ON has happened.

[541.115341] [FACT kms_selftest (drm_framebuffer)] new: kernel.is_tainted.taint_warn: true
[541.116327] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: gem_ctx_param
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: kms_atomic_interruptible
results: parsing output: 5/ for test: kms_big_fb
results: parsing output: 6/ for test: perf_pmu
results: parsing output: 7/ for test: kms_plane
results: parsing output: 8/ for test: gem_ctx_isolation
results: parsing output: 9/ for test: gem_exec_balancer
results: parsing output: 10/ for test: kms_plane
results: parsing output: 11/ for test: gem_mmap_gtt
results: parsing output: 12/ for test: kms_big_fb
results: parsing output: 13/ for test: kms_lease
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_flip_event_leak
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: kms_chamelium_audio
results: parsing output: 18/ for test: kms_invalid_mode
results: parsing output: 19/ for test: kms_big_fb
results: parsing output: 20/ for test: kms_frontbuffer_tracking
results: parsing output: 21/ for test: kms_plane_cursor
results: parsing output: 22/ for test: kms_cursor_crc
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: kms_prime
results: parsing output: 25/ for test: kms_dirtyfb
results: parsing output: 26/ for test: kms_color_pipeline
results: parsing output: 27/ for test: kms_psr2_sf
results: parsing output: 28/ for test: gem_ctx_param
results: parsing output: 29/ for test: kms_psr2_sf
results: parsing output: 30/ for test: kms_big_fb
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: vgem_basic
results: parsing output: 33/ for test: kms_flip
results: parsing output: 34/ for test: gem_exec_schedule
results: parsing output: 35/ for test: gem_caching
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: kms_big_fb
results: parsing output: 38/ for test: kms_ccs
results: parsing output: 39/ for test: kms_pm_rpm
results: parsing output: 40/ for test: kms_flip
results: parsing output: 41/ for test: i915_pm_rps
results: parsing output: 42/ for test: kms_addfb_basic
results: parsing output: 43/ for test: i915_query
results: parsing output: 44/ for test: perf
results: parsing output: 45/ for test: gem_render_copy
results: parsing output: 46/ for test: kms_flip_scaled_crc
results: parsing output: 47/ for test: kms_big_fb
results: parsing output: 48/ for test: kms_hdmi_inject
results: parsing output: 49/ for test: perf_pmu
results: parsing output: 50/ for test: syncobj_wait
results: parsing output: 51/ for test: gem_exec_balancer
results: parsing output: 52/ for test: api_intel_allocator
results: parsing output: 53/ for test: sysfs_timeslice_duration
results: parsing output: 54/ for test: kms_big_fb
results: parsing output: 55/ for test: kms_psr
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: syncobj_timeline
results: parsing output: 58/ for test: gem_ctx_shared
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: gem_exec_reloc
results: parsing output: 61/ for test: kms_content_protection
results: parsing output: 62/ for test: gem_set_tiling_vs_blt
results: parsing output: 63/ for test: kms_cursor_legacy
results: parsing output: 64/ for test: kms_plane_scaling
results: parsing output: 65/ for test: gem_exec_schedule
results: parsing output: 66/ for test: gem_close_race
results: parsing output: 67/ for test: kms_getfb
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_chamelium_hpd
results: parsing output: 70/ for test: kms_vblank
results: parsing output: 71/ for test: kms_prop_blob
results: parsing output: 72/ for test: kms_flip
results: parsing output: 73/ for test: kms_cursor_crc
results: parsing output: 74/ for test: gem_exec_flush
results: parsing output: 75/ for test: kms_psr
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_chamelium_frames
results: parsing output: 78/ for test: gem_ctx_persistence
results: parsing output: 79/ for test: kms_frontbuffer_tracking
results: parsing output: 80/ for test: gem_softpin
results: parsing output: 81/ for test: kms_rotation_crc
results: parsing output: 82/ for test: kms_properties
results: parsing output: 83/ for test: kms_flip_scaled_crc
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_selftest
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 87/ for test: gem_exec_params
results: no output, setting notrun
results: parsing output: 88/ for test: perf
results: no output, setting notrun
results: parsing output: 89/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 90/ for test: kms_plane_scaling
results: no output, setting notrun
results: parsing output: 91/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 92/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 93/ for test: gem_mmap_wc
results: no output, setting notrun
results: parsing output: 94/ for test: gem_exec_whisper
results: no output, setting notrun
results: parsing output: 95/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 96/ for test: gem_vm_create
results: no output, setting notrun
results: parsing output: 97/ for test: gem_exec_schedule
results: no output, setting notrun
results: parsing output: 98/ for test: sw_sync
results: no output, setting notrun
results: parsing output: 99/ for test: gem_exec_params
results: no output, setting notrun
results: parsing output: 100/ for test: i915_drm_fdinfo
results: no output, setting notrun
results: parsing output: 101/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 102/ for test: kms_ccs
results: no output, setting notrun
results: parsing output: 103/ for test: i915_hangman
results: no output, setting notrun
results: parsing output: 104/ for test: gen9_exec_parse
results: no output, setting notrun
results: parsing output: 105/ for test: api_intel_bb
results: no output, setting notrun
results: parsing output: 106/ for test: kms_cursor_legacy
results: no output, setting notrun
results: parsing output: 107/ for test: perf_pmu
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_frontbuffer_tracking
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: kms_ccs
results: no output, setting notrun
results: parsing output: 112/ for test: gem_exec_fence
results: no output, setting notrun
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 114/ for test: template
results: no output, setting notrun
results: parsing output: 115/ for test: kms_getfb
results: no output, setting notrun
results: parsing output: 116/ for test: gem_mmap_gtt
results: no output, setting notrun
results: parsing output: 117/ for test: gem_media_vme
results: no output, setting notrun
results: parsing output: 118/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 119/ for test: kms_pipe_stress
results: no output, setting notrun
results: parsing output: 120/ for test: syncobj_timeline
results: no output, setting notrun
results: parsing output: 121/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: no output, setting notrun
results: parsing output: 123/ for test: kms_psr
results: no output, setting notrun
results: parsing output: 124/ for test: gem_lmem_swapping
results: no output, setting notrun
results: parsing output: 125/ for test: gem_busy
results: no output, setting notrun
results: parsing output: 126/ for test: kms_feature_discovery
results: no output, setting notrun
results: parsing output: 127/ for test: dmabuf_sync_file
results: no output, setting notrun
results: parsing output: 128/ for test: kms_rotation_crc
results: no output, setting notrun
results: parsing output: 129/ for test: gem_mmap_wc
results: no output, setting notrun
results: parsing output: 130/ for test: kms_atomic
results: no output, setting notrun
results: parsing output: 131/ for test: gem_workarounds
results: no output, setting notrun
results: parsing output: 132/ for test: gem_fenced_exec_thrash
results: no output, setting notrun
Done.