[45.647463] Initializing watchdogs
[45.647523]   /dev/watchdog0
[45.662704] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[45.667759] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[45.670285] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[45.672175] [001/130] (960s left) kms_chamelium_color (ctm-max)
[45.852669] Subtest ctm-max: SKIP (0.000s)
[45.891865] [002/130] (960s left) gem_ctx_persistence (userptr)
[45.933660] Starting subtest: userptr
[46.048782] Subtest userptr: SUCCESS (0.114s)
[46.114784] [003/130] (960s left) gem_mmap_offset (ptrace)
[46.149149] Starting subtest: ptrace
[46.150762] Starting dynamic subtest: smem0-gtt
[46.178876] Dynamic subtest smem0-gtt: SUCCESS (0.029s)
[46.183470] Starting dynamic subtest: smem0-wb
[46.197621] Dynamic subtest smem0-wb: SUCCESS (0.018s)
[46.203306] Starting dynamic subtest: smem0-wc
[46.219650] Dynamic subtest smem0-wc: SUCCESS (0.022s)
[46.225258] Starting dynamic subtest: smem0-uc
[46.241915] Dynamic subtest smem0-uc: SUCCESS (0.022s)
[46.242708] Subtest ptrace: SUCCESS (0.093s)
[46.352624] [004/130] (959s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[46.442491] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[46.443875] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[46.532367] [005/130] (959s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[46.625772] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s)
[46.657567] [006/130] (959s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[46.746626] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[46.747409] Starting dynamic subtest: pipe-A-HDMI-A-1
[46.754499] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[46.759344] Starting dynamic subtest: pipe-B-HDMI-A-1
[46.766591] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[46.771372] Starting dynamic subtest: pipe-C-HDMI-A-1
[46.778536] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[46.783930] Starting dynamic subtest: pipe-D-HDMI-A-1
[46.791038] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[46.792475] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.006s)
[46.998786] [007/130] (959s left) kms_invalid_mode (bad-vsync-end)
[47.090377] Starting subtest: bad-vsync-end
[47.091144] Starting dynamic subtest: pipe-A-HDMI-A-1
[47.142193] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.052s)
[47.147854] Starting dynamic subtest: pipe-B-HDMI-A-1
[47.148550] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[47.153587] Starting dynamic subtest: pipe-C-HDMI-A-1
[47.154289] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[47.158734] Starting dynamic subtest: pipe-D-HDMI-A-1
[47.159432] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[47.160130] Subtest bad-vsync-end: SUCCESS (0.061s)
[47.281624] [008/130] (959s left) kms_lease (lease-invalid-connector)
[47.372619] Starting subtest: lease-invalid-connector
[47.373372] Starting dynamic subtest: pipe-A-HDMI-A-1
[47.374130] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.000s)
[47.379585] Starting dynamic subtest: pipe-B-HDMI-A-1
[47.380298] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s)
[47.384960] Starting dynamic subtest: pipe-C-HDMI-A-1
[47.385730] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.000s)
[47.390213] Starting dynamic subtest: pipe-D-HDMI-A-1
[47.390921] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.000s)
[47.391719] Subtest lease-invalid-connector: SUCCESS (0.004s)
[47.442390] [009/130] (958s left) kms_psr (psr2-cursor-plane-move)
[47.531340] Subtest psr2-cursor-plane-move: SKIP (0.000s)
[47.566968] [010/130] (958s left) kms_plane_scaling (plane-scaler-with-clipping-clamping-pixel-formats)
[47.653746] Starting subtest: plane-scaler-with-clipping-clamping-pixel-formats
[47.654613] Starting dynamic subtest: pipe-A
[49.196577] Dynamic subtest pipe-A: SUCCESS (1.599s)
[49.202987] Starting dynamic subtest: pipe-B
[50.775538] Dynamic subtest pipe-B: SUCCESS (1.634s)
[50.784318] Starting dynamic subtest: pipe-C
[50.986786] Dynamic subtest pipe-C: SUCCESS (0.218s)
[50.992484] Starting dynamic subtest: pipe-D
[51.189105] Dynamic subtest pipe-D: SUCCESS (0.208s)
[51.189840] Subtest plane-scaler-with-clipping-clamping-pixel-formats: SUCCESS (3.660s)
[51.370207] [011/130] (954s left) kms_vblank (query-busy)
[51.459743] Starting subtest: query-busy
[51.460425] Starting dynamic subtest: pipe-A-HDMI-A-1
[52.689812] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.261s)
[52.697274] Starting dynamic subtest: pipe-D-HDMI-A-1
[53.911258] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.246s)
[53.912031] Subtest query-busy: SUCCESS (2.512s)
[54.031112] [012/130] (952s left) gem_pxp (regular-baseline-src-copy-readible)
[54.135628] Starting subtest: regular-baseline-src-copy-readible
[54.185594] Subtest regular-baseline-src-copy-readible: SUCCESS (0.053s)
[54.312294] [013/130] (952s left) i915_pm_rps (engine-order)
[54.351975] Starting subtest: engine-order
[58.491305] Subtest engine-order: SUCCESS (4.191s)
[58.624410] [014/130] (947s left) drm_fdinfo (busy-idle)
[58.662686] Starting subtest: busy-idle
[58.663415] Starting dynamic subtest: rcs0
[59.287573] Dynamic subtest rcs0: SUCCESS (0.631s)
[59.295421] Starting dynamic subtest: bcs0
[59.915528] Dynamic subtest bcs0: SUCCESS (0.634s)
[59.923814] Starting dynamic subtest: vcs0
[60.543598] Dynamic subtest vcs0: SUCCESS (0.633s)
[60.551233] Starting dynamic subtest: vcs1
[61.169482] Dynamic subtest vcs1: SUCCESS (0.630s)
[61.177574] Starting dynamic subtest: vecs0
[61.796323] Dynamic subtest vecs0: SUCCESS (0.631s)
[61.797325] Subtest busy-idle: SUCCESS (3.162s)
[61.864401] [015/130] (944s left) gem_mmap_gtt (ptrace)
[61.901574] Starting subtest: ptrace
[62.001566] Subtest ptrace: SUCCESS (0.101s)
[62.072343] [016/130] (944s left) gem_exec_reloc (basic-write-read)
[62.111743] Starting subtest: basic-write-read
[62.116621] Subtest basic-write-read: SUCCESS (0.005s)
[62.224685] [017/130] (944s left) kms_flip (2x-flip-vs-rmfb-interruptible)
[62.318193] Starting subtest: 2x-flip-vs-rmfb-interruptible
[62.327790] Subtest 2x-flip-vs-rmfb-interruptible: SKIP (0.009s)
[62.381939] [018/130] (944s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[62.473784] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[63.710897] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (1.245s)
[63.830600] [019/130] (942s left) gem_exec_gttfill (multigpu-basic)
[63.997744] Starting subtest: multigpu-basic
[86.347118] Subtest multigpu-basic: SUCCESS (22.385s)
[86.402683] [020/130] (920s left) prime_mmap (test_dup)
[86.489939] Starting subtest: test_dup
[86.490642] Starting dynamic subtest: test_dup-smem
[86.491338] Dynamic subtest test_dup-smem: SUCCESS (0.001s)
[86.492095] Subtest test_dup: SUCCESS (0.002s)
[86.565620] [021/130] (919s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[86.660156] Starting subtest: basic-flip-after-cursor-atomic
[87.186412] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.518s)
[87.305455] [022/130] (919s left) gem_render_copy_redux (interruptible)
[87.354498] Starting subtest: interruptible
[87.803827] Subtest interruptible: SUCCESS (0.441s)
[87.920025] [023/130] (918s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-shrfb-draw-mmap-cpu)
[88.014669] Starting subtest: fbc-1p-offscren-pri-shrfb-draw-mmap-cpu
[89.081929] Subtest fbc-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (1.068s)
[89.203857] [024/130] (917s left) i915_query (hwconfig_table)
[89.243894] Starting subtest: hwconfig_table
[89.245396] Subtest hwconfig_table: SKIP (0.000s)
[89.295518] [025/130] (917s left) kms_feature_discovery (chamelium)
[89.390811] Starting subtest: chamelium
[89.392460] Subtest chamelium: SKIP (0.000s)
[89.465796] [026/130] (917s left) kms_psr (psr-cursor-mmap-gtt)
[89.571724] Subtest psr-cursor-mmap-gtt: SKIP (0.000s)
[89.605654] [027/130] (917s left) kms_flip (2x-flip-vs-fences)
[89.700816] Starting subtest: 2x-flip-vs-fences
[89.709743] Subtest 2x-flip-vs-fences: SKIP (0.009s)
[89.773784] [028/130] (916s left) kms_flip (2x-blocking-wf_vblank)
[89.863296] Starting subtest: 2x-blocking-wf_vblank
[89.879400] Subtest 2x-blocking-wf_vblank: SKIP (0.015s)
[89.953350] [029/130] (916s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[90.040732] Starting subtest: cursorA-vs-flipA-atomic-transitions
[100.868669] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (10.819s)
[100.990312] [030/130] (905s left) gem_exec_fence (nb-await)
[101.164376] Starting subtest: nb-await
[101.165306] Starting dynamic subtest: rcs0
[101.225069] Dynamic subtest rcs0: SUCCESS (0.060s)
[101.237568] Starting dynamic subtest: bcs0
[101.287949] Dynamic subtest bcs0: SUCCESS (0.062s)
[101.300504] Starting dynamic subtest: vcs0
[101.349889] Dynamic subtest vcs0: SUCCESS (0.061s)
[101.362723] Starting dynamic subtest: vcs1
[101.411802] Dynamic subtest vcs1: SUCCESS (0.061s)
[101.424891] Starting dynamic subtest: vecs0
[101.475784] Dynamic subtest vecs0: SUCCESS (0.061s)
[101.476893] Subtest nb-await: SUCCESS (0.310s)
[101.968156] [FACT gem_exec_fence (nb-await)] new: kernel.kmod_is_loaded.vgem: true
[101.971677] [031/130] (904s left) kms_plane_scaling (plane-upscale-factor-0-25-with-rotation)
[102.059956] Starting subtest: plane-upscale-factor-0-25-with-rotation
[102.061068] Starting dynamic subtest: pipe-A
[103.163127] Dynamic subtest pipe-A: SKIP (1.102s)
[103.170911] Starting dynamic subtest: pipe-B
[104.245733] Dynamic subtest pipe-B: SKIP (1.083s)
[104.251829] Starting dynamic subtest: pipe-C
[105.325411] Dynamic subtest pipe-C: SKIP (1.078s)
[105.333172] Starting dynamic subtest: pipe-D
[106.446381] Dynamic subtest pipe-D: SKIP (1.120s)
[106.447985] Subtest plane-upscale-factor-0-25-with-rotation: SKIP (4.385s)
[106.637710] [032/130] (900s left) vgem_basic (debugfs)
[106.693971] Starting subtest: debugfs
[106.694732] Subtest debugfs: SUCCESS (0.001s)
[106.743463] [033/130] (900s left) vgem_basic (second-client)
[106.786503] Starting subtest: second-client
[106.802128] Subtest second-client: SUCCESS (0.016s)
[106.851475] [034/130] (900s left) kms_color (ctm-signed)
[106.944233] Starting subtest: ctm-signed
[106.944991] Starting dynamic subtest: pipe-A-HDMI-A-1
[107.483319] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.538s)
[107.490676] Starting dynamic subtest: pipe-B-HDMI-A-1
[108.010128] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.526s)
[108.018184] Starting dynamic subtest: pipe-C-HDMI-A-1
[108.538628] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.528s)
[108.546649] Starting dynamic subtest: pipe-D-HDMI-A-1
[109.076280] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.536s)
[109.076997] Subtest ctm-signed: SUCCESS (2.132s)
[109.215117] [035/130] (897s left) kms_plane_multiple (tiling-x)
[109.308101] Starting subtest: tiling-x
[109.308807] Starting dynamic subtest: pipe-A-HDMI-A-1
[109.883502] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.574s)
[109.891326] Starting dynamic subtest: pipe-B-HDMI-A-1
[110.473765] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.590s)
[110.482108] Starting dynamic subtest: pipe-C-HDMI-A-1
[111.074507] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.598s)
[111.082427] Starting dynamic subtest: pipe-D-HDMI-A-1
[111.651148] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.576s)
[111.651904] Subtest tiling-x: SUCCESS (2.344s)
[111.768685] [036/130] (895s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[111.869909] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[113.151945] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (1.282s)
[113.304753] [037/130] (893s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[113.343278] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[113.344055] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.001s)
[113.402454] [038/130] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[113.498897] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[113.500299] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[113.578066] [039/130] (893s left) gem_exec_store (dword)
[113.623365] Starting subtest: dword
[113.624285] Starting dynamic subtest: rcs0
[113.680919] Dynamic subtest rcs0: SUCCESS (0.056s)
[113.697965] Starting dynamic subtest: bcs0
[113.706635] Dynamic subtest bcs0: SUCCESS (0.024s)
[113.719832] Starting dynamic subtest: vcs0
[113.726124] Dynamic subtest vcs0: SUCCESS (0.018s)
[113.736253] Starting dynamic subtest: vcs1
[113.750679] Dynamic subtest vcs1: SUCCESS (0.023s)
[113.762905] Starting dynamic subtest: vecs0
[113.779825] Dynamic subtest vecs0: SUCCESS (0.027s)
[113.781151] Subtest dword: SUCCESS (0.157s)
[113.959704] [040/130] (893s left) kms_chamelium_hpd (dp-hpd-fast)
[114.102123] Subtest dp-hpd-fast: SKIP (0.000s)
[114.203335] [041/130] (893s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[114.302834] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[114.304244] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[114.399658] [042/130] (892s left) gem_exec_whisper (basic-sync-all)
[114.446075] Starting subtest: basic-sync-all
[115.963634] Subtest basic-sync-all: SUCCESS (1.516s)
[116.153488] [043/130] (891s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[116.249406] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[116.250886] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[116.322849] [044/130] (891s left) sw_sync (timeline_closed)
[116.358809] Starting subtest: timeline_closed
[116.359524] Subtest timeline_closed: SUCCESS (0.000s)
[116.420847] [045/130] (890s left) kms_big_fb (yf-tiled-addfb)
[116.520213] Starting subtest: yf-tiled-addfb
[116.521708] Subtest yf-tiled-addfb: SKIP (0.000s)
[116.632861] [046/130] (890s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[116.725021] Starting subtest: fbc-rgb101010-draw-blt
[119.188447] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.464s)
[119.314714] [047/130] (888s left) sw_sync (sync_merge)
[119.350241] Starting subtest: sync_merge
[119.350995] Subtest sync_merge: SUCCESS (0.000s)
[119.396883] [048/130] (888s left) gem_ctx_isolation (dirty-create)
[119.444804] Starting subtest: dirty-create
[119.445585] Starting dynamic subtest: rcs0
[119.892756] Dynamic subtest rcs0: SUCCESS (0.439s)
[119.898863] Starting dynamic subtest: bcs0
[120.381218] Dynamic subtest bcs0: SUCCESS (0.487s)
[120.387223] Starting dynamic subtest: vcs0
[120.878642] Dynamic subtest vcs0: SUCCESS (0.496s)
[120.884685] Starting dynamic subtest: vcs1
[121.364825] Dynamic subtest vcs1: SUCCESS (0.485s)
[121.371041] Starting dynamic subtest: vecs0
[121.862284] Dynamic subtest vecs0: SUCCESS (0.496s)
[121.863036] Subtest dirty-create: SUCCESS (2.409s)
[122.030403] [049/130] (885s left) syncobj_timeline (invalid-transfer-illegal-handle)
[122.067831] Starting subtest: invalid-transfer-illegal-handle
[122.068539] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[122.121481] [050/130] (885s left) kms_vblank (wait-busy-hang)
[122.210045] Starting subtest: wait-busy-hang
[122.211825] Starting dynamic subtest: pipe-A-HDMI-A-1
[135.873149] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (13.662s)
[135.884513] Starting dynamic subtest: pipe-D-HDMI-A-1
[149.667526] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (13.788s)
[149.669863] Subtest wait-busy-hang: SUCCESS (27.459s)
[149.820702] [051/130] (857s left) gem_pwrite_snooped
[149.993320] [052/130] (857s left) kms_busy (extended-pageflip-modeset-hang-oldfb)
[150.090499] Starting subtest: extended-pageflip-modeset-hang-oldfb
[150.091305] Starting dynamic subtest: pipe-A
[169.649932] Dynamic subtest pipe-A: SUCCESS (19.558s)
[169.661224] Starting dynamic subtest: pipe-D
[189.600361] Dynamic subtest pipe-D: SUCCESS (19.943s)
[189.601167] Subtest extended-pageflip-modeset-hang-oldfb: SUCCESS (39.509s)
[189.714248] [053/130] (817s left) perf (mi-rpc)
[189.808141] Starting subtest: mi-rpc
[189.809514] Subtest mi-rpc: SKIP (0.000s)
[189.845528] [054/130] (817s left) perf_pmu (event-wait)
[189.884500] Starting subtest: event-wait
[189.885250] Starting dynamic subtest: rcs0
[189.886722] Dynamic subtest rcs0: SKIP (0.000s)
[189.888162] Subtest event-wait: SKIP (0.001s)
[189.951918] [055/130] (817s left) core_auth (basic-auth)
[189.988961] Starting subtest: basic-auth
[189.989802] Subtest basic-auth: SUCCESS (0.000s)
[190.056886] [056/130] (817s left) kms_atomic_transition (plane-all-transition-nonblocking-fencing)
[190.148210] Starting subtest: plane-all-transition-nonblocking-fencing
[190.150091] Starting dynamic subtest: pipe-A-HDMI-A-1
[192.072240] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.914s)
[192.105902] Starting dynamic subtest: pipe-B-HDMI-A-1
[194.040087] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.931s)
[194.057717] Subtest plane-all-transition-nonblocking-fencing: SUCCESS (3.910s)
[194.207479] [057/130] (813s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[194.301815] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[194.303200] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[194.390482] [058/130] (813s left) gem_exec_params (mmapped)
[194.430020] Starting subtest: mmapped
[194.431967] Subtest mmapped: SUCCESS (0.001s)
[194.543361] [059/130] (813s left) gem_exec_balancer (busy)
[194.588375] Starting subtest: busy
[195.146414] Subtest busy: SUCCESS (0.558s)
[195.341774] [060/130] (812s left) kms_cursor_legacy (cursora-vs-flipa-legacy)
[195.433669] Starting subtest: cursorA-vs-flipA-legacy
[206.286217] Subtest cursorA-vs-flipA-legacy: SUCCESS (10.819s)
[206.404127] [061/130] (801s left) kms_psr (fbc-psr2-dpms)
[206.497708] Subtest fbc-psr2-dpms: SKIP (0.000s)
[206.537974] [062/130] (801s left) api_intel_bb (bb-with-allocator)
[206.576502] Starting subtest: bb-with-allocator
[206.578419] Subtest bb-with-allocator: SUCCESS (0.003s)
[206.690265] [063/130] (801s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu)
[206.781899] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu
[206.783336] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[206.890983] [064/130] (801s left) syncobj_eventfd (binary-wait)
[206.929129] Starting subtest: binary-wait
[206.939496] Subtest binary-wait: SUCCESS (0.010s)
[207.002220] [065/130] (801s left) gem_wait (busy)
[207.054180] Starting subtest: busy
[207.054957] Starting dynamic subtest: all-engines
[207.595182] Dynamic subtest all-engines: SUCCESS (0.540s)
[207.605300] Starting dynamic subtest: rcs0
[208.112963] Dynamic subtest rcs0: SUCCESS (0.517s)
[208.122356] Starting dynamic subtest: bcs0
[208.628911] Dynamic subtest bcs0: SUCCESS (0.515s)
[208.637148] Starting dynamic subtest: vcs0
[209.145941] Dynamic subtest vcs0: SUCCESS (0.516s)
[209.154137] Starting dynamic subtest: vcs1
[209.665027] Dynamic subtest vcs1: SUCCESS (0.518s)
[209.673707] Starting dynamic subtest: vecs0
[210.178364] Dynamic subtest vecs0: SUCCESS (0.512s)
[210.179157] Subtest busy: SUCCESS (3.124s)
[210.379314] [066/130] (797s left) kms_big_fb (x-tiled-addfb-size-overflow)
[210.481841] Starting subtest: x-tiled-addfb-size-overflow
[210.482601] Subtest x-tiled-addfb-size-overflow: SUCCESS (0.001s)
[210.572624] [067/130] (797s left) kms_cursor_legacy (forked-move)
[210.661217] Starting subtest: forked-move
[210.661999] Starting dynamic subtest: pipe-A
[216.140458] Dynamic subtest pipe-A: SUCCESS (5.442s)
[216.147380] Starting dynamic subtest: pipe-B
[221.584488] Dynamic subtest pipe-B: SUCCESS (5.446s)
[221.591043] Starting dynamic subtest: pipe-C
[227.023099] Dynamic subtest pipe-C: SUCCESS (5.438s)
[227.029902] Starting dynamic subtest: pipe-D
[232.473848] Dynamic subtest pipe-D: SUCCESS (5.449s)
[232.481291] Starting dynamic subtest: all-pipes
[237.928810] Dynamic subtest all-pipes: SUCCESS (5.453s)
[237.929821] Subtest forked-move: SUCCESS (27.233s)
[237.968968] [068/130] (770s left) kms_dither (fb-8bpc-vs-panel-6bpc)
[238.060572] Starting subtest: fb-8bpc-vs-panel-6bpc
[238.061323] Starting dynamic subtest: pipe-A-HDMI-A-1
[238.122839] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.061s)
[238.124351] Subtest fb-8bpc-vs-panel-6bpc: SKIP (0.062s)
[238.242829] [069/130] (770s left) kms_frontbuffer_tracking (psr-1p-rte)
[238.337901] Starting subtest: psr-1p-rte
[238.339323] Subtest psr-1p-rte: SKIP (0.000s)
[238.427163] [070/130] (769s left) kms_psr (pr-dpms)
[238.516170] Subtest pr-dpms: SKIP (0.000s)
[238.558671] [071/130] (769s left) kms_flip (bo-too-big-interruptible)
[238.652325] Starting subtest: bo-too-big-interruptible
[238.655128] Starting dynamic subtest: A-HDMI-A1
[239.484037] Dynamic subtest A-HDMI-A1: SUCCESS (0.828s)
[239.496987] Starting dynamic subtest: B-HDMI-A1
[240.306345] Dynamic subtest B-HDMI-A1: SUCCESS (0.817s)
[240.313468] Starting dynamic subtest: C-HDMI-A1
[241.136869] Dynamic subtest C-HDMI-A1: SUCCESS (0.829s)
[241.143765] Starting dynamic subtest: D-HDMI-A1
[241.971187] Dynamic subtest D-HDMI-A1: SUCCESS (0.829s)
[241.971949] Subtest bo-too-big-interruptible: SUCCESS (3.316s)
[242.192657] [072/130] (766s left) kms_content_protection (dp-mst-type-1)
[242.305085] Starting subtest: dp-mst-type-1
[242.306472] Subtest dp-mst-type-1: SKIP (0.000s)
[242.409964] [073/130] (766s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs)
[242.500145] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs
[242.500905] Starting dynamic subtest: pipe-A-HDMI-A-1
[243.155736] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.651s)
[243.168811] Starting dynamic subtest: pipe-B-HDMI-A-1
[243.658122] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.497s)
[243.670839] Starting dynamic subtest: pipe-C-HDMI-A-1
[244.174522] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.512s)
[244.187155] Starting dynamic subtest: pipe-D-HDMI-A-1
[244.691326] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.512s)
[244.692421] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SUCCESS (2.189s)
[244.895595] [074/130] (763s left) kms_addfb_basic (invalid-get-prop-any)
[244.935202] Starting subtest: invalid-get-prop-any
[244.935992] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[245.090267] [075/130] (763s left) gem_caching (writes)
[245.130182] Starting subtest: writes
[254.012390] Subtest writes: SUCCESS (8.882s)
[254.132066] [076/130] (754s left) kms_big_fb (linear-16bpp-rotate-90)
[254.230782] Starting subtest: linear-16bpp-rotate-90
[254.318307] Subtest linear-16bpp-rotate-90: SKIP (0.087s)
[254.434734] [077/130] (754s left) gem_exec_schedule (preempt-queue-contexts-chain)
[254.485179] Starting subtest: preempt-queue-contexts-chain
[254.485961] Starting dynamic subtest: rcs0
[254.795115] Dynamic subtest rcs0: SUCCESS (0.301s)
[254.802407] Starting dynamic subtest: bcs0
[255.105369] Dynamic subtest bcs0: SUCCESS (0.309s)
[255.114387] Starting dynamic subtest: vcs0
[255.410168] Dynamic subtest vcs0: SUCCESS (0.304s)
[255.417161] Starting dynamic subtest: vcs1
[255.720041] Dynamic subtest vcs1: SUCCESS (0.309s)
[255.727435] Starting dynamic subtest: vecs0
[256.014900] Dynamic subtest vecs0: SUCCESS (0.294s)
[256.015703] Subtest preempt-queue-contexts-chain: SUCCESS (1.522s)
[256.311113] [078/130] (752s left) kms_scaling_modes (scaling-mode-full-aspect)
[256.406267] Starting subtest: scaling-mode-full-aspect
[256.410401] Subtest scaling-mode-full-aspect: SKIP (0.001s)
[256.463807] [079/130] (752s left) gem_lmem_swapping (heavy-verify-random)
[256.503898] Subtest heavy-verify-random: SKIP (0.000s)
[256.543009] [080/130] (752s left) kms_psr (fbc-psr2-cursor-mmap-cpu)
[256.631816] Subtest fbc-psr2-cursor-mmap-cpu: SKIP (0.000s)
[256.674868] [081/130] (752s left) syncobj_basic (test-valid-cycle)
[256.717338] Starting subtest: test-valid-cycle
[256.718362] Subtest test-valid-cycle: SUCCESS (0.000s)
[256.775667] [082/130] (751s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[256.870101] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[256.907958] [083/130] (751s left) gem_exec_reloc (basic-cpu-active)
[256.948199] Starting subtest: basic-cpu-active
[257.078776] Subtest basic-cpu-active: SUCCESS (0.121s)
[257.191053] [084/130] (751s left) syncobj_timeline (wait-all-complex)
[257.234419] Starting subtest: wait-all-complex
[257.456918] Subtest wait-all-complex: SUCCESS (0.214s)
[257.517257] [085/130] (751s left) kms_atomic (atomic-plane-damage)
[257.606991] Starting subtest: atomic-plane-damage
[257.665207] Starting dynamic subtest: pipe-A-HDMI-A-1
[257.888047] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.223s)
[257.888801] Subtest atomic-plane-damage: SUCCESS (0.282s)
[258.033946] [086/130] (750s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-upscaling)
[258.128907] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-upscaling
[258.129610] Starting dynamic subtest: pipe-A-valid-mode
[258.188825] Dynamic subtest pipe-A-valid-mode: SKIP (0.058s)
[258.190473] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-upscaling: SKIP (0.060s)
[258.332101] [087/130] (750s left) kms_plane_alpha_blend (coverage-7efc)
[258.419964] Starting subtest: coverage-7efc
[258.519225] Starting dynamic subtest: pipe-A-HDMI-A-1
[258.778353] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.258s)
[258.809111] Starting dynamic subtest: pipe-D-HDMI-A-1
[259.225569] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.424s)
[259.226353] Subtest coverage-7efc: SUCCESS (0.806s)
[259.383514] [088/130] (749s left) api_intel_bb (simple-bb-ctx)
[259.422653] Starting subtest: simple-bb-ctx
[259.426234] Subtest simple-bb-ctx: SUCCESS (0.004s)
[259.543855] [089/130] (749s left) gem_userptr_blits (mmap-offset-banned)
[259.594188] Starting subtest: mmap-offset-banned
[259.595042] Starting dynamic subtest: gtt
[259.595856] Dynamic subtest gtt: SUCCESS (0.000s)
[259.602665] Starting dynamic subtest: wb
[259.603459] Dynamic subtest wb: SUCCESS (0.000s)
[259.609929] Starting dynamic subtest: wc
[259.611512] Dynamic subtest wc: SUCCESS (0.000s)
[259.617771] Starting dynamic subtest: uc
[259.618509] Dynamic subtest uc: SUCCESS (0.000s)
[259.619216] Subtest mmap-offset-banned: SUCCESS (0.004s)
[259.714623] [090/130] (749s left) gem_userptr_blits (unsync-unmap)
[259.758927] Subtest unsync-unmap: SKIP (0.000s)
[259.887286] [091/130] (749s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[259.985313] Starting subtest: psr-1p-primscrn-pri-indfb-draw-mmap-gtt
[259.986713] Subtest psr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[260.094786] [092/130] (749s left) kms_big_fb (4-tiled-32bpp-rotate-0)
[260.193786] Starting subtest: 4-tiled-32bpp-rotate-0
[260.195173] Subtest 4-tiled-32bpp-rotate-0: SKIP (0.000s)
[260.303935] [093/130] (748s left) gen9_exec_parse (bb-oversize)
[260.345579] Subtest bb-oversize: SKIP (0.000s)
[260.386754] [094/130] (748s left) kms_cursor_crc (cursor-rapid-movement-64x64)
[260.479039] Starting subtest: cursor-rapid-movement-64x64
[260.484088] Starting dynamic subtest: pipe-A-HDMI-A-1
[260.740136] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.257s)
[260.782206] Starting dynamic subtest: pipe-D-HDMI-A-1
[260.985154] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.208s)
[260.985937] Subtest cursor-rapid-movement-64x64: SUCCESS (0.507s)
[261.116547] [095/130] (748s left) gem_render_copy (yf-tiled-ccs-to-y-tiled-ccs)
[261.163817] Starting subtest: yf-tiled-ccs-to-y-tiled-ccs
[261.164545] Starting dynamic subtest: smem
[261.287780] Dynamic subtest smem: SUCCESS (0.115s)
[261.288596] Subtest yf-tiled-ccs-to-y-tiled-ccs: SUCCESS (0.116s)
[261.467519] [096/130] (747s left) gem_unref_active_buffers
[261.633940] [097/130] (747s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[261.732422] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[262.065499] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.333s)
[262.195242] [098/130] (747s left) core_getclient
[262.303309] [099/130] (747s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[262.400011] Starting subtest: y-tiled-64bpp-rotate-180
[264.550118] Subtest y-tiled-64bpp-rotate-180: SUCCESS (2.149s)
[264.736815] [100/130] (744s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[264.835445] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[264.836958] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[264.917188] [101/130] (744s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-onoff)
[265.011703] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-onoff
[265.013178] Subtest fbcpsr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[265.125269] [102/130] (744s left) kms_rotation_crc (primary-yf-tiled-reflect-x-180)
[265.219947] Starting subtest: primary-yf-tiled-reflect-x-180
[265.275609] Subtest primary-yf-tiled-reflect-x-180: SKIP (0.055s)
[265.352940] [103/130] (744s left) kms_cursor_crc (cursor-random-64x64)
[265.445095] Starting subtest: cursor-random-64x64
[265.450064] Starting dynamic subtest: pipe-A-HDMI-A-1
[267.363998] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.914s)
[267.397160] Starting dynamic subtest: pipe-D-HDMI-A-1
[269.268999] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.880s)
[269.269846] Subtest cursor-random-64x64: SUCCESS (3.824s)
[269.402008] [104/130] (740s left) perf_pmu (init-busy)
[269.442152] Starting subtest: init-busy
[269.442943] Starting dynamic subtest: rcs0
[269.443672] Dynamic subtest rcs0: SUCCESS (0.001s)
[269.450201] Starting dynamic subtest: bcs0
[269.450936] Dynamic subtest bcs0: SUCCESS (0.000s)
[269.457433] Starting dynamic subtest: vcs0
[269.458169] Dynamic subtest vcs0: SUCCESS (0.000s)
[269.464410] Starting dynamic subtest: vcs1
[269.465127] Dynamic subtest vcs1: SUCCESS (0.000s)
[269.471488] Starting dynamic subtest: vecs0
[269.472186] Dynamic subtest vecs0: SUCCESS (0.000s)
[269.473638] Subtest init-busy: SUCCESS (0.006s)
[269.510718] [105/130] (740s left) perf (per-context-mode-unprivileged)
[269.584816] Starting subtest: per-context-mode-unprivileged
[269.586295] Subtest per-context-mode-unprivileged: SKIP (0.000s)
[269.623538] [106/130] (740s left) gem_ctx_persistence (engines-mixed-process)
[269.664137] Starting subtest: engines-mixed-process
[269.664886] Starting dynamic subtest: rcs0
[270.090797] Dynamic subtest rcs0: SUCCESS (0.426s)
[270.107162] Starting dynamic subtest: bcs0
[270.488948] Dynamic subtest bcs0: SUCCESS (0.396s)
[270.507744] Starting dynamic subtest: vcs0
[270.860854] Dynamic subtest vcs0: SUCCESS (0.369s)
[270.880615] Starting dynamic subtest: vcs1
[271.234794] Dynamic subtest vcs1: SUCCESS (0.371s)
[271.246928] Starting dynamic subtest: vecs0
[271.612287] Dynamic subtest vecs0: SUCCESS (0.375s)
[271.613549] Subtest engines-mixed-process: SUCCESS (1.948s)
[271.687468] [107/130] (738s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-mmap-wc)
[271.786639] Starting subtest: psr-1p-offscren-pri-indfb-draw-mmap-wc
[271.788218] Subtest psr-1p-offscren-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[271.886403] [108/130] (737s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[271.981490] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[271.983016] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[272.078520] [109/130] (737s left) i915_pm_freq_api (freq-suspend)
[272.121860] Subtest freq-suspend: SKIP (0.000s)
[272.162280] [110/130] (737s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[272.199138] Starting subtest: multi-wait-for-submit-available-submitted
[272.199851] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[272.268160] [111/130] (737s left) kms_chamelium_audio (dp-audio-edid)
[272.407995] Subtest dp-audio-edid: SKIP (0.000s)
[272.501662] [112/130] (737s left) kms_big_fb (x-tiled-32bpp-rotate-0)
[272.600718] Starting subtest: x-tiled-32bpp-rotate-0
[274.337127] Subtest x-tiled-32bpp-rotate-0: SUCCESS (1.736s)
[274.479750] [113/130] (735s left) gem_ccs (ctrl-surf-copy-new-ctx)
[274.543951] Starting subtest: ctrl-surf-copy-new-ctx
[274.545374] Subtest ctrl-surf-copy-new-ctx: SKIP (0.000s)
[274.602998] [114/130] (735s left) kms_frontbuffer_tracking (fbcpsr-tiling-4)
[274.698740] Starting subtest: fbcpsr-tiling-4
[274.700224] Subtest fbcpsr-tiling-4: SKIP (0.000s)
[274.807549] [115/130] (735s left) kms_atomic_transition (plane-all-modeset-transition-fencing-internal-panels)
[274.898158] Starting subtest: plane-all-modeset-transition-fencing-internal-panels
[274.899668] Subtest plane-all-modeset-transition-fencing-internal-panels: SKIP (0.000s)
[274.954851] [116/130] (735s left) kms_pm_rpm (cursor)
[276.364802] Starting subtest: cursor
[288.753949] Subtest cursor: SUCCESS (12.389s)
[288.925819] [117/130] (721s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs)
[289.013112] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs
[289.013896] Starting dynamic subtest: pipe-A-HDMI-A-1
[289.021094] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[289.027928] Starting dynamic subtest: pipe-B-HDMI-A-1
[289.035197] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[289.041948] Starting dynamic subtest: pipe-C-HDMI-A-1
[289.049049] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[289.055709] Starting dynamic subtest: pipe-D-HDMI-A-1
[289.062608] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[289.064074] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs: SKIP (0.008s)
[289.252069] [118/130] (720s left) kms_addfb_basic (unused-handle)
[289.291121] Starting subtest: unused-handle
[289.291873] Subtest unused-handle: SUCCESS (0.000s)
[289.438344] [119/130] (720s left) kms_frontbuffer_tracking (fbc-2p-indfb-fliptrack-mmap-gtt)
[289.532715] Starting subtest: fbc-2p-indfb-fliptrack-mmap-gtt
[289.534201] Subtest fbc-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[289.638250] [120/130] (720s left) gem_mmap_gtt (basic-write)
[289.673791] Starting subtest: basic-write
[289.819743] Subtest basic-write: SUCCESS (0.137s)
[289.908500] [121/130] (720s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-render)
[290.003142] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-render
[290.004569] Subtest psr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[290.123669] [122/130] (720s left) prime_mmap_coherency (read)
[290.163637] Starting subtest: read
[295.583734] Subtest read: SUCCESS (5.386s)
[295.676869] [123/130] (714s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[295.715351] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[295.825359] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.108s)
[295.893756] [124/130] (714s left) gem_exec_flush (basic-batch-kernel-default-uc)
[295.940232] Starting subtest: basic-batch-kernel-default-uc
[301.587143] Subtest basic-batch-kernel-default-uc: SUCCESS (5.647s)
[301.791592] [125/130] (708s left) syncobj_wait (multi-wait-submitted)
[301.830292] Starting subtest: multi-wait-submitted
[301.935722] Subtest multi-wait-submitted: SUCCESS (0.105s)
[302.010848] [126/130] (708s left) kms_setmode (invalid-clone-exclusive-crtc)
[302.049350] Starting subtest: invalid-clone-exclusive-crtc
[302.051463] Subtest invalid-clone-exclusive-crtc: SKIP (0.001s)
[302.117989] [127/130] (708s left) gem_softpin (allocator-basic-reserve)
[302.158102] Starting subtest: allocator-basic-reserve
[302.227127] Subtest allocator-basic-reserve: SUCCESS (0.069s)
[302.371129] [128/130] (708s left) fbdev (nullptr)
[302.413115] Starting subtest: nullptr
[302.413891] Subtest nullptr: SUCCESS (0.000s)
[302.466744] [129/130] (708s left) kms_prop_blob (blob-prop-core)
[302.504852] Starting subtest: blob-prop-core
[302.505599] Subtest blob-prop-core: SUCCESS (0.000s)
[302.564200] [130/130] (708s left) gem_exec_balancer (parallel)
[302.730388] Subtest parallel: SKIP (0.000s)
[302.795483] Closing watchdogs
Done.