[71.555349] Initializing watchdogs
[71.555392]   /dev/watchdog0
[71.588946] [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]
[71.593380] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[71.595541] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[71.598986] [001/156] (960s left) gem_ctx_persistence (legacy-engines-hostile)
[71.689484] Starting subtest: legacy-engines-hostile
[71.692311] Starting dynamic subtest: render
[71.828802] Dynamic subtest render: SUCCESS (0.139s)
[71.840364] Starting dynamic subtest: bsd1
[71.928447] Dynamic subtest bsd1: SUCCESS (0.097s)
[71.938086] Starting dynamic subtest: bsd2
[72.031426] Dynamic subtest bsd2: SUCCESS (0.102s)
[72.042171] Starting dynamic subtest: blt
[72.124718] Dynamic subtest blt: SUCCESS (0.092s)
[72.137361] Starting dynamic subtest: vebox
[72.298662] Dynamic subtest vebox: SUCCESS (0.169s)
[72.301043] Subtest legacy-engines-hostile: SUCCESS (0.607s)
[72.374482] [002/156] (959s left) kms_frontbuffer_tracking (hdr-1p-primscrn-cur-indfb-draw-pwrite)
[72.621754] Starting subtest: hdr-1p-primscrn-cur-indfb-draw-pwrite
[72.625540] Subtest hdr-1p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[72.822941] [003/156] (959s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[72.948395] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[72.950691] Starting dynamic subtest: pipe-A-eDP-1
[72.973452] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[72.982535] Starting dynamic subtest: pipe-B-eDP-1
[73.004508] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[73.012271] Starting dynamic subtest: pipe-C-eDP-1
[73.033456] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[73.040874] Starting dynamic subtest: pipe-D-eDP-1
[73.062930] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[73.067115] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[75.270483] [004/156] (956s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu)
[75.377204] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu
[82.233190] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.862s)
[82.366134] [005/156] (949s left) kms_properties (colorop-properties-legacy)
[82.457375] Starting subtest: colorop-properties-legacy
[82.461091] Starting dynamic subtest: pipe-A-eDP-1
[82.845336] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.384s)
[82.855675] Starting dynamic subtest: pipe-B-eDP-1
[83.916222] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.072s)
[83.925516] Starting dynamic subtest: pipe-C-eDP-1
[85.024521] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.106s)
[85.032380] Starting dynamic subtest: pipe-D-eDP-1
[86.168410] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.144s)
[86.170686] Subtest colorop-properties-legacy: SUCCESS (3.710s)
[87.046603] [006/156] (945s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc)
[87.135825] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc
[87.138087] Starting dynamic subtest: pipe-A-eDP-1
[87.160867] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[87.172393] Starting dynamic subtest: pipe-B-eDP-1
[87.194633] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[87.204223] Starting dynamic subtest: pipe-C-eDP-1
[87.225110] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[87.233754] Starting dynamic subtest: pipe-D-eDP-1
[87.255204] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[87.259389] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s)
[89.397902] [007/156] (942s left) api_intel_allocator (fork-simple-stress)
[89.448824] Starting subtest: fork-simple-stress
[94.845780] Subtest fork-simple-stress: SUCCESS (5.397s)
[94.972665] [008/156] (937s left) gem_mmap (short-mmap)
[95.038369] Subtest short-mmap: SKIP (0.000s)
[95.104364] [009/156] (937s left) sw_sync (sync_expired_merge)
[95.139060] Starting subtest: sync_expired_merge
[96.214045] Subtest sync_expired_merge: SUCCESS (1.074s)
[96.273961] [010/156] (936s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic)
[96.396594] Starting subtest: 2x-cursor-vs-flip-atomic
[96.401394] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s)
[96.536664] [011/156] (935s left) gem_bad_reloc (negative-reloc)
[96.604116] Subtest negative-reloc: SKIP (0.000s)
[96.679092] [012/156] (935s left) perf_pmu (render-node-busy)
[96.763279] Starting subtest: render-node-busy
[96.765521] Starting dynamic subtest: rcs0
[97.381378] Dynamic subtest rcs0: SUCCESS (0.619s)
[97.390692] Starting dynamic subtest: bcs0
[97.940578] Dynamic subtest bcs0: SUCCESS (0.558s)
[97.950519] Starting dynamic subtest: vcs0
[99.334043] Dynamic subtest vcs0: SUCCESS (1.390s)
[99.345964] Starting dynamic subtest: vcs1
[101.318464] Dynamic subtest vcs1: SUCCESS (1.983s)
[101.329873] Starting dynamic subtest: vecs0
[103.302147] Dynamic subtest vecs0: SUCCESS (1.983s)
[103.312835] Starting dynamic subtest: ccs0
[103.866332] Dynamic subtest ccs0: SUCCESS (0.564s)
[103.868851] Subtest render-node-busy: SUCCESS (7.105s)
[103.940424] [013/156] (928s left) i915_fb_tiling (basic-x-tiling)
[104.003269] Subtest basic-x-tiling: SKIP (0.000s)
[104.056190] [014/156] (928s left) kms_cursor_crc (cursor-offscreen-32x10)
[104.230693] Starting subtest: cursor-offscreen-32x10
[104.278117] Subtest cursor-offscreen-32x10: SKIP (0.043s)
[104.543841] [015/156] (928s left) gem_mmap_gtt (basic-write-read-distinct)
[104.604960] Subtest basic-write-read-distinct: SKIP (0.000s)
[104.663723] [016/156] (928s left) kms_chamelium_color (ctm-0-50)
[104.758254] Subtest ctm-0-50: SKIP (0.000s)
[104.801798] [017/156] (927s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-pwrite)
[104.902182] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-pwrite
[104.905502] Subtest psrhdr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[104.991408] [018/156] (927s left) kms_big_fb (linear-32bpp-rotate-0)
[105.086014] Starting subtest: linear-32bpp-rotate-0
[106.575665] Subtest linear-32bpp-rotate-0: SUCCESS (1.489s)
[106.705225] [019/156] (926s left) gem_tiled_partial_pwrite_pread (reads)
[106.766144] Subtest reads: SKIP (0.000s)
[106.840355] [020/156] (926s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-blt)
[106.948518] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-blt
[106.951964] Subtest psr-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[107.045906] [021/156] (925s left) gem_exec_schedule (u-fairslice)
[107.114834] Starting subtest: u-fairslice
[107.116548] Starting dynamic subtest: rcs0
[109.138079] Dynamic subtest rcs0: SUCCESS (2.024s)
[109.149078] Starting dynamic subtest: bcs0
[111.154716] Dynamic subtest bcs0: SUCCESS (2.016s)
[111.164662] Starting dynamic subtest: vcs0
[113.173019] Dynamic subtest vcs0: SUCCESS (2.019s)
[113.182413] Starting dynamic subtest: vcs1
[115.193212] Dynamic subtest vcs1: SUCCESS (2.019s)
[115.202366] Starting dynamic subtest: vecs0
[117.211720] Dynamic subtest vecs0: SUCCESS (2.018s)
[117.223854] Starting dynamic subtest: ccs0
[119.231265] Dynamic subtest ccs0: SUCCESS (2.020s)
[119.233371] Subtest u-fairslice: SUCCESS (12.118s)
[119.520529] [022/156] (913s left) gem_mmap_gtt (fault-concurrent-y)
[119.584712] Subtest fault-concurrent-Y: SKIP (0.000s)
[119.639867] [023/156] (913s left) kms_chamelium_frames (hdmi-crc-multiple)
[120.030153] Subtest hdmi-crc-multiple: SKIP (0.000s)
[120.814856] [024/156] (912s left) kms_cursor_crc (cursor-sliding-max-size)
[121.103084] Starting subtest: cursor-sliding-max-size
[121.109833] Subtest cursor-sliding-max-size: SKIP (0.000s)
[121.251536] [025/156] (911s left) gem_softpin (evict-active)
[121.315469] Starting subtest: evict-active
[121.320274] Subtest evict-active: SUCCESS (0.004s)
[121.455109] [026/156] (911s left) gem_exec_balancer (bonded-chain)
[121.508317] Starting subtest: bonded-chain
[128.500319] Subtest bonded-chain: SUCCESS (6.990s)
[128.823478] [027/156] (904s left) kms_atomic (atomic-invalid-params)
[128.919018] Starting subtest: atomic-invalid-params
[128.921421] Starting dynamic subtest: pipe-A-eDP-1
[129.307026] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.388s)
[129.309569] Subtest atomic-invalid-params: SUCCESS (0.389s)
[130.155991] [028/156] (903s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-blt)
[130.252844] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-blt
[130.257479] Subtest psrhdr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[130.341252] [029/156] (902s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[130.439822] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[137.857919] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.423s)
[137.968481] [030/156] (895s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[138.064318] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[138.068792] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[138.158026] [031/156] (895s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-pwrite)
[138.255457] Starting subtest: fbc-rgb101010-draw-pwrite
[141.602070] Subtest fbc-rgb101010-draw-pwrite: SUCCESS (3.352s)
[142.783510] [032/156] (890s left) kms_frontbuffer_tracking (fbcpsr-2p-pri-indfb-multidraw)
[142.881946] Starting subtest: fbcpsr-2p-pri-indfb-multidraw
[142.886490] Subtest fbcpsr-2p-pri-indfb-multidraw: SKIP (0.000s)
[142.988535] [033/156] (890s left) gem_ctx_engines (invalid-engines)
[143.060035] Starting subtest: invalid-engines
[143.064696] Subtest invalid-engines: SUCCESS (0.007s)
[143.297540] [034/156] (890s left) kms_frontbuffer_tracking (fbchdr-modesetfrombusy)
[143.392665] Starting subtest: fbchdr-modesetfrombusy
[143.396798] Subtest fbchdr-modesetfrombusy: SKIP (0.000s)
[143.491470] [035/156] (889s left) kms_cursor_crc (cursor-random-32x10)
[143.648675] Starting subtest: cursor-random-32x10
[143.703210] Subtest cursor-random-32x10: SKIP (0.051s)
[143.966231] [036/156] (889s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf)
[144.060480] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf
[144.064718] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[144.125876] [037/156] (889s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[144.229086] Starting subtest: yf-tiled-8bpp-rotate-0
[144.232538] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[144.317770] [038/156] (889s left) syncobj_wait (invalid-multi-wait-unsubmitted)
[144.370663] Starting subtest: invalid-multi-wait-unsubmitted
[144.372555] Subtest invalid-multi-wait-unsubmitted: SUCCESS (0.000s)
[144.462299] [039/156] (889s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-cur-indfb-move)
[144.559939] Starting subtest: fbcpsrhdr-1p-primscrn-cur-indfb-move
[144.563507] Subtest fbcpsrhdr-1p-primscrn-cur-indfb-move: SKIP (0.000s)
[144.650847] [040/156] (889s left) kms_color (ctm-0-25)
[144.737296] Starting subtest: ctm-0-25
[144.738965] Starting dynamic subtest: pipe-A-eDP-1
[148.307669] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.571s)
[148.317778] Starting dynamic subtest: pipe-B-eDP-1
[152.576899] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.268s)
[152.589143] Starting dynamic subtest: pipe-C-eDP-1
[156.735152] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.157s)
[156.745163] Starting dynamic subtest: pipe-D-eDP-1
[160.728408] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.993s)
[160.730761] Subtest ctm-0-25: SUCCESS (15.991s)
[161.544624] [041/156] (872s left) gem_pread (exhaustion)
[161.603585] Subtest exhaustion: SKIP (0.000s)
[161.664579] [042/156] (872s left) perf (blocking)
[161.788315] Starting subtest: blocking
[161.790401] Starting dynamic subtest: 0-rcs0
[171.812132] Dynamic subtest 0-rcs0: SUCCESS (10.022s)
[171.822320] Starting dynamic subtest: 1-vcs0
[181.832690] Dynamic subtest 1-vcs0: SUCCESS (10.019s)
[181.835045] Subtest blocking: SUCCESS (20.042s)
[181.879264] [043/156] (851s left) i915_suspend (forcewake)
[181.930521] Starting subtest: forcewake
[213.891919] Subtest forcewake: SUCCESS (3.127s)
[213.957447] [044/156] (819s left) kms_plane_scaling (planes-downscale-factor-0-5-upscale-20x20)
[214.055602] Starting subtest: planes-downscale-factor-0-5-upscale-20x20
[214.057936] Starting dynamic subtest: pipe-A
[214.078292] Dynamic subtest pipe-A: SKIP (0.019s)
[214.090128] Starting dynamic subtest: pipe-B
[214.114014] Dynamic subtest pipe-B: SKIP (0.035s)
[214.123513] Starting dynamic subtest: pipe-C
[214.150674] Dynamic subtest pipe-C: SKIP (0.036s)
[214.160427] Starting dynamic subtest: pipe-D
[214.185544] Dynamic subtest pipe-D: SKIP (0.033s)
[214.189630] Subtest planes-downscale-factor-0-5-upscale-20x20: SKIP (0.126s)
[214.294823] [045/156] (819s left) kms_frontbuffer_tracking (psr-suspend)
[214.397302] Starting subtest: psr-suspend
[252.448479] Subtest psr-suspend: SUCCESS (7.915s)
[252.583930] [046/156] (781s left) syncobj_timeline (multi-wait-for-submit-available-submitted-signaled)
[252.654108] Starting subtest: multi-wait-for-submit-available-submitted-signaled
[252.656172] Subtest multi-wait-for-submit-available-submitted-signaled: SUCCESS (0.001s)
[252.759424] [047/156] (781s left) kms_frontbuffer_tracking (hdr-2p-primscrn-spr-indfb-draw-render)
[252.856678] Starting subtest: hdr-2p-primscrn-spr-indfb-draw-render
[252.860749] Subtest hdr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[252.961283] [048/156] (781s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[253.065390] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt
[253.069577] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[253.162765] [049/156] (780s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[253.265568] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[258.278182] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (5.012s)
[258.406308] [050/156] (775s left) kms_psr (fbc-psr-cursor-blt)
[258.512945] Starting subtest: fbc-psr-cursor-blt
[258.515210] Starting dynamic subtest: eDP-1
[258.519680] Dynamic subtest eDP-1: SKIP (0.000s)
[258.524191] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[258.584187] [051/156] (775s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[258.677971] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[258.680101] Starting dynamic subtest: pipe-A-default-mode
[261.419978] Dynamic subtest pipe-A-default-mode: SUCCESS (2.737s)
[261.421946] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.739s)
[262.269760] [052/156] (771s left) gem_workarounds (basic-read-context)
[262.337619] Starting subtest: basic-read-context
[262.347380] Subtest basic-read-context: SUCCESS (0.010s)
[262.480939] [053/156] (771s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-submitted-signa
[262.532288] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled
[262.639811] Subtest etime-multi-wait-all-for-submit-unsubmitted-submitted-signaled: SUCCESS (0.106s)
[262.722555] [054/156] (771s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling)
[262.824192] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling
[262.828542] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.000s)
[262.896072] [055/156] (771s left) gem_readwrite (new-obj)
[262.943422] Subtest new-obj: SKIP (0.000s)
[262.998143] [056/156] (771s left) gem_ctx_persistence (engines-persistence)
[263.047542] Starting subtest: engines-persistence
[263.049821] Starting dynamic subtest: rcs0
[263.839544] Dynamic subtest rcs0: SUCCESS (0.791s)
[263.852303] Starting dynamic subtest: bcs0
[264.596464] Dynamic subtest bcs0: SUCCESS (0.754s)
[264.609369] Starting dynamic subtest: vcs0
[265.366634] Dynamic subtest vcs0: SUCCESS (0.767s)
[265.378765] Starting dynamic subtest: vcs1
[266.133193] Dynamic subtest vcs1: SUCCESS (0.764s)
[266.143926] Starting dynamic subtest: vecs0
[266.920278] Dynamic subtest vecs0: SUCCESS (0.784s)
[266.930586] Starting dynamic subtest: ccs0
[267.672640] Dynamic subtest ccs0: SUCCESS (0.749s)
[267.675235] Subtest engines-persistence: SUCCESS (4.623s)
[267.752181] [057/156] (766s left) kms_busy (extended-pageflip-hang-newfb)
[267.867907] Starting subtest: extended-pageflip-hang-newfb
[267.870685] Starting dynamic subtest: pipe-A
[282.036923] Dynamic subtest pipe-A: SUCCESS (14.160s)
[282.048020] Starting dynamic subtest: pipe-D
[307.054485] Dynamic subtest pipe-D: SUCCESS (25.005s)
[307.057018] Subtest extended-pageflip-hang-newfb: SUCCESS (39.170s)
[307.948603] [058/156] (726s left) kms_big_fb (4-tiled-64bpp-rotate-270)
[308.057385] Starting subtest: 4-tiled-64bpp-rotate-270
[308.079266] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.021s)
[308.193269] [059/156] (726s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-spr-indfb-draw-render)
[308.292763] Starting subtest: hdr-2p-scndscrn-spr-indfb-draw-render
[308.297221] Subtest hdr-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s)
[308.396771] [060/156] (726s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-indfb-draw-blt)
[308.489432] Starting subtest: hdr-2p-primscrn-pri-indfb-draw-blt
[308.493969] Subtest hdr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[308.579540] [061/156] (725s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[308.681915] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[315.984826] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SUCCESS (7.306s)
[316.083218] [062/156] (718s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[316.178496] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[316.182765] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[316.282589] [063/156] (718s left) sysfs_heartbeat_interval (mixed)
[316.331948] Starting subtest: mixed
[316.334394] Starting dynamic subtest: vecs0
[321.531576] Dynamic subtest vecs0: SUCCESS (5.194s)
[321.544106] Starting dynamic subtest: ccs0
[326.760772] Dynamic subtest ccs0: SUCCESS (5.227s)
[326.772358] Starting dynamic subtest: vcs0
[331.941611] Dynamic subtest vcs0: SUCCESS (5.177s)
[331.954817] Starting dynamic subtest: bcs0
[337.151956] Dynamic subtest bcs0: SUCCESS (5.206s)
[337.164569] Starting dynamic subtest: rcs0
[342.336194] Dynamic subtest rcs0: SUCCESS (5.181s)
[342.349003] Starting dynamic subtest: vcs1
[347.540573] Dynamic subtest vcs1: SUCCESS (5.202s)
[347.543137] Subtest mixed: SUCCESS (31.197s)
[347.617691] [064/156] (686s left) gem_softpin (allocator-basic-reserve)
[347.676858] Starting subtest: allocator-basic-reserve
[347.757405] Subtest allocator-basic-reserve: SUCCESS (0.080s)
[347.892385] [065/156] (686s left) kms_pm_dc (dc5-dpms)
[348.993640] Starting subtest: dc5-dpms
[351.079157] Subtest dc5-dpms: SUCCESS (2.085s)
[351.158311] [066/156] (683s left) gen7_exec_parse (load-register-reg)
[351.218754] Subtest load-register-reg: SKIP (0.000s)
[351.304904] [067/156] (683s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen)
[351.406481] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen
[351.410987] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[351.487273] [068/156] (683s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-pri-indfb-draw-render)
[351.574971] Starting subtest: psrhdr-1p-primscrn-pri-indfb-draw-render
[351.579175] Subtest psrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[351.668750] [069/156] (683s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[351.781849] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[352.729893] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.947s)
[353.556837] [070/156] (681s left) gem_exec_params (dr4-dirt)
[353.610092] Starting subtest: DR4-dirt
[353.612465] Subtest DR4-dirt: SUCCESS (0.000s)
[353.706603] [071/156] (681s left) gem_workarounds (suspend-resume-context)
[353.760409] Starting subtest: suspend-resume-context
[369.893696] Subtest suspend-resume-context: SUCCESS (1.162s)
[370.027873] [072/156] (664s left) kms_addfb_basic (bad-pitch-65536)
[370.082566] Starting subtest: bad-pitch-65536
[370.084718] Subtest bad-pitch-65536: SUCCESS (0.000s)
[370.207541] [073/156] (664s left) gem_userptr_blits (access-control)
[370.266919] Starting subtest: access-control
[370.271147] Subtest access-control: SKIP (0.000s)
[370.372166] [074/156] (664s left) syncobj_wait (multi-wait-for-submit-submitted-signaled)
[370.423793] Starting subtest: multi-wait-for-submit-submitted-signaled
[370.425706] Subtest multi-wait-for-submit-submitted-signaled: SUCCESS (0.000s)
[370.522016] [075/156] (664s left) gem_exec_whisper (basic-queues-forked)
[370.578851] Starting subtest: basic-queues-forked
[393.586427] Subtest basic-queues-forked: SUCCESS (22.987s)
[393.768078] [076/156] (641s left) kms_frontbuffer_tracking (fbcpsrhdr-stridechange)
[393.866857] Starting subtest: fbcpsrhdr-stridechange
[393.870899] Subtest fbcpsrhdr-stridechange: SKIP (0.000s)
[393.969285] [077/156] (641s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-render)
[394.075428] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-render
[394.079358] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s)
[394.183519] [078/156] (640s left) kms_frontbuffer_tracking (hdr-rgb101010-draw-mmap-cpu)
[394.276212] Starting subtest: hdr-rgb101010-draw-mmap-cpu
[394.280220] Subtest hdr-rgb101010-draw-mmap-cpu: SKIP (0.000s)
[394.375096] [079/156] (640s left) syncobj_wait (wait-all-complex)
[394.426708] Starting subtest: wait-all-complex
[394.639312] Subtest wait-all-complex: SUCCESS (0.213s)
[394.714464] [080/156] (640s left) gem_fenced_exec_thrash (no-spare-fences)
[394.761626] Subtest no-spare-fences: SKIP (0.000s)
[394.846719] [081/156] (640s left) kms_plane_multiple (2x-tiling-4)
[394.929944] Starting subtest: 2x-tiling-4
[394.934492] Subtest 2x-tiling-4: SKIP (0.000s)
[395.005321] [082/156] (640s left) kms_vrr (flipline)
[395.098595] Starting subtest: flipline
[395.105065] Subtest flipline: SKIP (0.000s)
[395.170131] [083/156] (640s left) gem_wait (await)
[395.235118] Starting subtest: await
[395.237550] Starting dynamic subtest: all-engines
[396.408011] Dynamic subtest all-engines: SUCCESS (1.172s)
[396.427674] Starting dynamic subtest: rcs0
[397.463880] Dynamic subtest rcs0: SUCCESS (1.053s)
[397.481322] Starting dynamic subtest: bcs0
[398.522357] Dynamic subtest bcs0: SUCCESS (1.056s)
[398.540359] Starting dynamic subtest: vcs0
[399.575096] Dynamic subtest vcs0: SUCCESS (1.050s)
[399.595663] Starting dynamic subtest: vcs1
[400.631945] Dynamic subtest vcs1: SUCCESS (1.053s)
[400.649362] Starting dynamic subtest: vecs0
[401.687222] Dynamic subtest vecs0: SUCCESS (1.052s)
[401.704405] Starting dynamic subtest: ccs0
[402.744326] Dynamic subtest ccs0: SUCCESS (1.054s)
[402.747104] Subtest await: SUCCESS (7.507s)
[402.941266] [FACT gem_wait (await)] new: kernel.kmod_is_loaded.vgem: true
[402.944989] [084/156] (632s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc)
[403.058263] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc
[403.062621] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[403.156756] [085/156] (632s left) kms_psr (fbc-pr-sprite-plane-move)
[403.259285] Starting subtest: fbc-pr-sprite-plane-move
[403.264064] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[403.328564] [086/156] (632s left) gem_exec_whisper (basic-fds-priority-all)
[403.384389] Starting subtest: basic-fds-priority-all
[427.194837] Subtest basic-fds-priority-all: SUCCESS (23.805s)
[427.375760] [087/156] (608s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[427.482907] Starting subtest: fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc
[427.486956] Subtest fbchdr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[427.585757] [088/156] (607s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[427.677625] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-gtt
[427.681939] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[427.774033] [089/156] (607s left) gem_exec_fence (syncobj-timeline-unused-fence)
[428.412731] Starting subtest: syncobj-timeline-unused-fence
[428.418835] Subtest syncobj-timeline-unused-fence: SUCCESS (0.007s)
[430.341836] [090/156] (605s left) kms_psr (psr2-cursor-plane-onoff)
[430.438339] Starting subtest: psr2-cursor-plane-onoff
[430.440782] Starting dynamic subtest: eDP-1
[432.189540] Dynamic subtest eDP-1: SUCCESS (1.750s)
[432.191862] Subtest psr2-cursor-plane-onoff: SUCCESS (1.751s)
[433.073735] [091/156] (602s left) kms_flip (flip-vs-fences-interruptible)
[433.168805] Starting subtest: flip-vs-fences-interruptible
[433.172953] Subtest flip-vs-fences-interruptible: SKIP (0.000s)
[433.264340] [092/156] (602s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping)
[433.363264] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping
[433.367234] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s)
[433.434550] [093/156] (602s left) kms_draw_crc (draw-method-blt)
[433.525450] Starting subtest: draw-method-blt
[433.527370] Starting dynamic subtest: xrgb8888-untiled
[433.771150] Dynamic subtest xrgb8888-untiled: SUCCESS (0.248s)
[433.781474] Starting dynamic subtest: rgb565-untiled
[434.004067] Dynamic subtest rgb565-untiled: SUCCESS (0.233s)
[434.016243] Starting dynamic subtest: xrgb2101010-untiled
[434.226193] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s)
[434.237176] Starting dynamic subtest: xbgr16161616f-untiled
[434.459606] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.233s)
[434.470690] Starting dynamic subtest: xrgb8888-xtiled
[434.581646] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.121s)
[434.591332] Starting dynamic subtest: rgb565-xtiled
[434.704164] Dynamic subtest rgb565-xtiled: SUCCESS (0.122s)
[434.715217] Starting dynamic subtest: xrgb2101010-xtiled
[434.815274] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s)
[434.825265] Starting dynamic subtest: xbgr16161616f-xtiled
[434.926394] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.110s)
[434.936693] Starting dynamic subtest: xrgb8888-4tiled
[435.059735] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.133s)
[435.069517] Starting dynamic subtest: rgb565-4tiled
[435.170836] Dynamic subtest rgb565-4tiled: SUCCESS (0.110s)
[435.183738] Starting dynamic subtest: xrgb2101010-4tiled
[435.282211] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.109s)
[435.297402] Starting dynamic subtest: xbgr16161616f-4tiled
[435.404151] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.120s)
[435.406060] Subtest draw-method-blt: SUCCESS (1.882s)
[435.512150] [094/156] (600s left) gem_exec_balancer (bonded-sync)
[435.582008] Starting subtest: bonded-sync
[435.585798] Subtest bonded-sync: SKIP (0.000s)
[435.897159] [095/156] (599s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[435.950544] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[435.952989] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[436.049080] [096/156] (599s left) gem_ppgtt (blt-vs-render-ctx0)
[436.107320] Starting subtest: blt-vs-render-ctx0
[469.016557] Subtest blt-vs-render-ctx0: SUCCESS (32.898s)
[469.146366] [097/156] (566s left) gem_exec_schedule (preempt)
[469.280680] Starting subtest: preempt
[469.282682] Starting dynamic subtest: rcs0
[469.308773] Dynamic subtest rcs0: SUCCESS (0.034s)
[469.320015] Starting dynamic subtest: bcs0
[469.339436] Dynamic subtest bcs0: SUCCESS (0.030s)
[469.352295] Starting dynamic subtest: vcs0
[469.372844] Dynamic subtest vcs0: SUCCESS (0.032s)
[469.384299] Starting dynamic subtest: vcs1
[469.399829] Dynamic subtest vcs1: SUCCESS (0.027s)
[469.410355] Starting dynamic subtest: vecs0
[469.432379] Dynamic subtest vecs0: SUCCESS (0.032s)
[469.442907] Starting dynamic subtest: ccs0
[469.464765] Dynamic subtest ccs0: SUCCESS (0.031s)
[469.467755] Subtest preempt: SUCCESS (0.190s)
[471.338100] [098/156] (564s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-fullscreen)
[471.456084] Starting subtest: psr-2p-primscrn-spr-indfb-fullscreen
[471.460274] Subtest psr-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[471.554556] [099/156] (564s left) gem_exec_fence (submit67)
[471.727799] Starting subtest: submit67
[471.732426] Subtest submit67: SKIP (0.000s)
[473.320030] [100/156] (562s left) i915_pm_rc6_residency (rc6-idle)
[473.365380] Starting subtest: rc6-idle
[473.385672] Starting dynamic subtest: gt0-rcs0
[497.658727] Dynamic subtest gt0-rcs0: SUCCESS (24.275s)
[497.669781] Starting dynamic subtest: gt0-bcs0
[522.049717] Dynamic subtest gt0-bcs0: SUCCESS (24.387s)
[522.060833] Starting dynamic subtest: gt0-ccs0
[546.487539] Dynamic subtest gt0-ccs0: SUCCESS (24.432s)
[546.500614] Starting dynamic subtest: gt1-vcs0
[552.660366] Dynamic subtest gt1-vcs0: SUCCESS (6.169s)
[552.674156] Starting dynamic subtest: gt1-vecs0
[558.835416] Dynamic subtest gt1-vecs0: SUCCESS (6.169s)
[558.838575] Subtest rc6-idle: SUCCESS (85.467s)
[558.920245] [101/156] (477s left) kms_flip (2x-flip-vs-absolute-wf_vblank)
[559.021284] Starting subtest: 2x-flip-vs-absolute-wf_vblank
[559.034968] Subtest 2x-flip-vs-absolute-wf_vblank: SKIP (0.014s)
[559.130006] [102/156] (477s left) gem_exec_parallel (fds)
[559.191738] Starting subtest: fds
[559.194022] Starting dynamic subtest: rcs0
[562.012846] Dynamic subtest rcs0: SUCCESS (2.818s)
[562.027271] Starting dynamic subtest: bcs0
[565.446665] Dynamic subtest bcs0: SUCCESS (3.431s)
[565.461177] Starting dynamic subtest: vcs0
[569.501146] Dynamic subtest vcs0: SUCCESS (4.052s)
[569.515296] Starting dynamic subtest: vcs1
[573.479926] Dynamic subtest vcs1: SUCCESS (3.976s)
[573.492531] Starting dynamic subtest: vecs0
[577.446701] Dynamic subtest vecs0: SUCCESS (3.963s)
[577.458405] Starting dynamic subtest: ccs0
[581.129422] Dynamic subtest ccs0: SUCCESS (3.679s)
[581.132357] Subtest fds: SUCCESS (21.933s)
[581.326109] [103/156] (454s left) gem_exec_suspend (basic-s3-devices)
[581.384401] Starting subtest: basic-S3-devices
[581.387566] Starting dynamic subtest: smem
[593.239490] Dynamic subtest smem: SUCCESS (11.854s)
[593.242591] Subtest basic-S3-devices: SUCCESS (11.856s)
[593.422452] [104/156] (442s left) kms_lease (invalid-create-leases)
[593.535936] Starting subtest: invalid-create-leases
[593.540702] Subtest invalid-create-leases: SUCCESS (0.005s)
[593.655157] [105/156] (442s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[593.765851] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[600.540740] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.781s)
[600.666507] [106/156] (435s left) syncobj_wait (wait-for-submit-snapshot)
[600.727019] Starting subtest: wait-for-submit-snapshot
[600.808082] Subtest wait-for-submit-snapshot: SUCCESS (0.082s)
[600.882822] [107/156] (435s left) dumb_buffer (map-uaf)
[600.936382] Starting subtest: map-uaf
[600.940392] Subtest map-uaf: SUCCESS (0.007s)
[601.062957] [108/156] (435s left) kms_invalid_mode (uint-max-clock)
[601.157681] Starting subtest: uint-max-clock
[601.159919] Starting dynamic subtest: pipe-A-eDP-1
[601.446028] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.289s)
[601.462185] Starting dynamic subtest: pipe-B-eDP-1
[601.464457] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[601.475283] Starting dynamic subtest: pipe-C-eDP-1
[601.477202] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[601.487558] Starting dynamic subtest: pipe-D-eDP-1
[601.490383] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[601.493180] Subtest uint-max-clock: SUCCESS (0.294s)
[602.308423] [109/156] (434s left) kms_vblank (ts-continuation-idle)
[602.398907] Starting subtest: ts-continuation-idle
[602.400772] Starting dynamic subtest: pipe-A-eDP-1
[602.795291] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.396s)
[602.812481] Starting dynamic subtest: pipe-D-eDP-1
[603.895313] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.097s)
[603.897295] Subtest ts-continuation-idle: SUCCESS (1.496s)
[604.764102] [110/156] (431s left) kms_dp_link_training (uhbr-sst)
[604.858424] Starting subtest: uhbr-sst
[604.867338] Subtest uhbr-sst: SKIP (0.000s)
[604.937969] [111/156] (431s left) gem_partial_pwrite_pread (reads-snoop)
[604.987669] Subtest reads-snoop: SKIP (0.000s)
[605.057498] [112/156] (431s left) perf_pmu (enable-race)
[605.093414] Starting subtest: enable-race
[605.095422] Starting dynamic subtest: rcs0
[617.868011] Dynamic subtest rcs0: SUCCESS (12.777s)
[617.880200] Starting dynamic subtest: bcs0
[630.611151] Dynamic subtest bcs0: SUCCESS (12.740s)
[630.621811] Starting dynamic subtest: vcs0
[646.229883] Dynamic subtest vcs0: SUCCESS (15.616s)
[646.243597] Starting dynamic subtest: vcs1
[662.230282] Dynamic subtest vcs1: SUCCESS (15.998s)
[662.243454] Starting dynamic subtest: vecs0
[678.230285] Dynamic subtest vecs0: SUCCESS (15.996s)
[678.247925] Starting dynamic subtest: ccs0
[690.984974] Dynamic subtest ccs0: SUCCESS (12.752s)
[690.987549] Subtest enable-race: SUCCESS (85.891s)
[691.105584] [113/156] (345s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff)
[691.218438] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff
[691.222861] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[691.327281] [114/156] (345s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-0-hflip)
[691.444892] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-0-hflip
[691.449279] Subtest y-tiled-max-hw-stride-32bpp-rotate-0-hflip: SKIP (0.000s)
[691.531099] [115/156] (345s left) kms_psr (pr-no-drrs)
[691.622398] Starting subtest: pr-no-drrs
[691.626767] Subtest pr-no-drrs: SKIP (0.000s)
[691.710015] [116/156] (345s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-blt)
[691.800703] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-blt
[691.804837] Subtest psrhdr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[691.895493] [117/156] (344s left) kms_psr (psr2-sprite-plane-onoff)
[691.981678] Starting subtest: psr2-sprite-plane-onoff
[691.983602] Starting dynamic subtest: eDP-1
[693.775306] Dynamic subtest eDP-1: SUCCESS (1.793s)
[693.777736] Subtest psr2-sprite-plane-onoff: SUCCESS (1.794s)
[694.624430] [118/156] (342s left) gem_render_copy (x-tiled-to-vebox-y-tiled)
[694.682801] Starting subtest: x-tiled-to-vebox-y-tiled
[694.687085] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s)
[694.864460] [119/156] (342s left) tools_test (tools_test)
[694.911748] Starting subtest: tools_test
[694.958008] Subtest tools_test: SUCCESS (0.059s)
[695.021913] [120/156] (341s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-wc)
[695.120737] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-wc
[699.132324] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (4.016s)
[700.329684] [121/156] (336s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[700.426657] Starting subtest: addfb25-y-tiled-legacy
[700.429032] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[700.515052] [122/156] (336s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc)
[700.610833] Starting subtest: fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc
[700.615616] Subtest fbchdr-1p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[700.720779] [123/156] (336s left) kms_frontbuffer_tracking (psrhdr-indfb-scaledprimary)
[700.812396] Starting subtest: psrhdr-indfb-scaledprimary
[700.816885] Subtest psrhdr-indfb-scaledprimary: SKIP (0.000s)
[700.911426] [124/156] (336s left) kms_dsc (dsc-with-output-formats-with-bpc-bigjoiner)
[701.010689] Starting subtest: dsc-with-output-formats-with-bpc-bigjoiner
[701.015093] Subtest dsc-with-output-formats-with-bpc-bigjoiner: SKIP (0.000s)
[701.085271] [125/156] (336s left) gem_mmap_offset (clear-via-pagefault)
[701.142430] Starting subtest: clear-via-pagefault
[701.144749] Starting dynamic subtest: smem0
[762.416399] [126/156] (274s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[762.570609] Starting subtest: plane-lut1d-ctm3x4
[762.717303] Starting dynamic subtest: pipe-A-plane-0
[762.894822] Dynamic subtest pipe-A-plane-0: SUCCESS (0.177s)
[762.907866] Starting dynamic subtest: pipe-A-plane-1
[763.050545] Dynamic subtest pipe-A-plane-1: SUCCESS (0.155s)
[763.062422] Starting dynamic subtest: pipe-A-plane-2
[763.207972] Dynamic subtest pipe-A-plane-2: SUCCESS (0.155s)
[764.452745] Starting dynamic subtest: pipe-B-plane-0
[764.609411] Dynamic subtest pipe-B-plane-0: SUCCESS (0.166s)
[764.621980] Starting dynamic subtest: pipe-B-plane-1
[764.765204] Dynamic subtest pipe-B-plane-1: SUCCESS (0.155s)
[764.778195] Starting dynamic subtest: pipe-B-plane-2
[764.920707] Dynamic subtest pipe-B-plane-2: SUCCESS (0.155s)
[766.164714] Starting dynamic subtest: pipe-C-plane-0
[766.286676] Dynamic subtest pipe-C-plane-0: SUCCESS (0.133s)
[766.302936] Starting dynamic subtest: pipe-C-plane-1
[766.453096] Dynamic subtest pipe-C-plane-1: SUCCESS (0.166s)
[766.468030] Starting dynamic subtest: pipe-C-plane-2
[766.620010] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s)
[767.794274] Starting dynamic subtest: pipe-D-plane-0
[767.938041] Dynamic subtest pipe-D-plane-0: SUCCESS (0.155s)
[767.951301] Starting dynamic subtest: pipe-D-plane-1
[768.105766] Dynamic subtest pipe-D-plane-1: SUCCESS (0.166s)
[768.120237] Starting dynamic subtest: pipe-D-plane-2
[768.269481] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s)
[768.557704] Subtest plane-lut1d-ctm3x4: SUCCESS (5.985s)
[769.366512] [127/156] (267s left) kms_big_fb (x-tiled-8bpp-rotate-90)
[769.485383] Starting subtest: x-tiled-8bpp-rotate-90
[769.508544] Subtest x-tiled-8bpp-rotate-90: SKIP (0.022s)
[769.688427] [128/156] (267s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render)
[769.850369] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render
[769.855689] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[770.106357] [129/156] (267s left) kms_content_protection (content-type-change)
[770.319352] Starting subtest: content-type-change
[770.323928] Subtest content-type-change: SKIP (0.000s)
[770.509722] [130/156] (266s left) vgem_basic (setversion)
[770.568406] Starting subtest: setversion
[770.572858] Subtest setversion: SUCCESS (0.000s)
[770.628962] [131/156] (266s left) gem_render_copy (y-tiled-mc-ccs-to-y-tiled-ccs)
[770.689953] Starting subtest: y-tiled-mc-ccs-to-y-tiled-ccs
[770.694693] Subtest y-tiled-mc-ccs-to-y-tiled-ccs: SKIP (0.000s)
[770.888945] [132/156] (266s left) kms_rotation_crc (primary-4-tiled-reflect-x-0)
[770.982768] Starting subtest: primary-4-tiled-reflect-x-0
[777.950485] Subtest primary-4-tiled-reflect-x-0: SUCCESS (6.966s)
[779.119029] [133/156] (258s left) i915_drm_fdinfo (busy-idle-check-all)
[779.164827] Starting subtest: busy-idle-check-all
[779.167217] Starting dynamic subtest: rcs0
[779.171914] Dynamic subtest rcs0: SKIP (0.004s)
[779.185713] Starting dynamic subtest: bcs0
[779.189876] Dynamic subtest bcs0: SKIP (0.000s)
[779.202111] Starting dynamic subtest: vcs0
[779.206669] Dynamic subtest vcs0: SKIP (0.000s)
[779.219187] Starting dynamic subtest: vcs1
[779.223705] Dynamic subtest vcs1: SKIP (0.000s)
[779.235262] Starting dynamic subtest: vecs0
[779.239708] Dynamic subtest vecs0: SKIP (0.000s)
[779.251935] Starting dynamic subtest: ccs0
[779.256445] Dynamic subtest ccs0: SKIP (0.000s)
[779.260910] Subtest busy-idle-check-all: SKIP (0.008s)
[779.300830] [134/156] (258s left) kms_frontbuffer_tracking (fbc-1p-rte)
[779.421297] Starting subtest: fbc-1p-rte
[784.894272] Subtest fbc-1p-rte: SUCCESS (5.478s)
[786.043991] [135/156] (251s left) kms_lease (lease-unleased-crtc)
[786.142058] Starting subtest: lease-unleased-crtc
[786.144169] Starting dynamic subtest: pipe-A-eDP-1
[786.439348] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.296s)
[786.450982] Starting dynamic subtest: pipe-B-eDP-1
[787.176963] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.735s)
[787.192887] Starting dynamic subtest: pipe-C-eDP-1
[787.195153] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.007s)
[787.207209] Starting dynamic subtest: pipe-D-eDP-1
[787.209469] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.006s)
[787.211747] Subtest lease-unleased-crtc: SUCCESS (1.051s)
[787.572893] [136/156] (250s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[787.669479] Starting subtest: fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[787.673569] Subtest fbcpsrhdr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[787.769997] [137/156] (249s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc)
[787.855695] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc
[787.857995] Starting dynamic subtest: pipe-A-eDP-1
[788.747558] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.885s)
[788.760939] Starting dynamic subtest: pipe-B-eDP-1
[790.430818] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.679s)
[790.444701] Starting dynamic subtest: pipe-C-eDP-1
[792.031763] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.601s)
[792.050313] Starting dynamic subtest: pipe-D-eDP-1
[793.578253] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.545s)
[793.580443] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs-cc: SUCCESS (5.714s)
[794.809706] [138/156] (242s left) syncobj_timeline (single-wait-for-submit-available-signaled)
[794.870164] Starting subtest: single-wait-for-submit-available-signaled
[794.872571] Subtest single-wait-for-submit-available-signaled: SUCCESS (0.000s)
[794.949543] [139/156] (242s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[795.053739] Starting subtest: pr-overlay-plane-move-continuous-sf
[795.058142] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[795.136550] [140/156] (242s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-mmap-gtt)
[795.236479] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-mmap-gtt
[795.240584] Subtest fbc-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[795.350486] [141/156] (242s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[795.398706] Starting subtest: invalid-multi-wait-all-unsubmitted
[795.400936] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[795.496780] [142/156] (242s left) drm_read (invalid-buffer)
[795.651858] Starting subtest: invalid-buffer
[795.654365] Subtest invalid-buffer: SUCCESS (0.000s)
[795.793325] [143/156] (242s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[795.896669] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[800.308996] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.415s)
[801.505401] [144/156] (236s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-indfb-pgflip-blt)
[801.607904] Starting subtest: psrhdr-2p-scndscrn-indfb-pgflip-blt
[801.612496] Subtest psrhdr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[801.709827] [145/156] (236s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[801.807105] Starting subtest: yf-tiled-32bpp-rotate-180
[801.811509] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[801.916199] [146/156] (236s left) gem_exec_endless (dispatch)
[801.983375] Starting subtest: dispatch
[801.985778] Starting dynamic subtest: rcs0
[801.989975] Dynamic subtest rcs0: SUCCESS (0.005s)
[802.002507] Starting dynamic subtest: bcs0
[802.007221] Dynamic subtest bcs0: SUCCESS (0.005s)
[802.019866] Starting dynamic subtest: vcs0
[802.024686] Dynamic subtest vcs0: SUCCESS (0.004s)
[802.035908] Starting dynamic subtest: vcs1
[802.039975] Dynamic subtest vcs1: SUCCESS (0.004s)
[802.050907] Starting dynamic subtest: vecs0
[802.054961] Dynamic subtest vecs0: SUCCESS (0.006s)
[802.066282] Starting dynamic subtest: ccs0
[802.070437] Dynamic subtest ccs0: SUCCESS (0.008s)
[802.072358] Subtest dispatch: SUCCESS (0.037s)
[803.279960] [147/156] (234s left) api_intel_bb (object-noreloc-purge-cache-simple)
[803.328612] Starting subtest: object-noreloc-purge-cache-simple
[803.331296] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.005s)
[803.447806] [148/156] (234s left) gem_render_copy (y-tiled)
[803.496190] Starting subtest: y-tiled
[803.500840] Subtest y-tiled: SKIP (0.000s)
[803.695710] [149/156] (234s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[803.785211] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[803.789302] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[803.894773] [150/156] (234s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-shrfb-pgflip-blt)
[803.990648] Starting subtest: fbchdr-1p-primscrn-shrfb-pgflip-blt
[803.994795] Subtest fbchdr-1p-primscrn-shrfb-pgflip-blt: SKIP (0.000s)
[804.093391] [151/156] (234s left) kms_pm_rpm (basic-pci-d3-state)
[806.432172] Starting subtest: basic-pci-d3-state
[807.909930] Subtest basic-pci-d3-state: SUCCESS (1.482s)
[808.043476] [152/156] (230s left) kms_ccs (random-ccs-data-4-tiled-dg2-mc-ccs)
[808.137027] Starting subtest: random-ccs-data-4-tiled-dg2-mc-ccs
[808.139315] Starting dynamic subtest: pipe-A-eDP-1
[808.164371] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[808.177453] Starting dynamic subtest: pipe-B-eDP-1
[808.201223] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[808.213658] Starting dynamic subtest: pipe-C-eDP-1
[808.237746] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[808.249298] Starting dynamic subtest: pipe-D-eDP-1
[808.274304] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[808.278404] Subtest random-ccs-data-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[810.439117] [153/156] (228s left) syncobj_eventfd (binary-wait-signaled)
[810.500331] Starting subtest: binary-wait-signaled
[810.502308] Subtest binary-wait-signaled: SUCCESS (0.000s)
[810.627141] [154/156] (227s left) kms_plane (pixel-format-4-tiled-dg2-rc-ccs-cc-modifier)
[810.730777] Starting subtest: pixel-format-4-tiled-dg2-rc-ccs-cc-modifier
[810.734852] Subtest pixel-format-4-tiled-dg2-rc-ccs-cc-modifier: SKIP (0.000s)
[810.818084] [155/156] (227s left) kms_rotation_crc (bad-pixel-format)
[810.915535] Starting subtest: bad-pixel-format
[810.919893] Subtest bad-pixel-format: SKIP (0.001s)
[810.992923] [156/156] (227s left) syncobj_wait (invalid-single-wait-unsubmitted)
[811.047160] Starting subtest: invalid-single-wait-unsubmitted
[811.049158] Subtest invalid-single-wait-unsubmitted: SUCCESS (0.000s)
[811.124436] Closing watchdogs
results: parsing output: 0/ for test: gem_ctx_persistence
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_ccs
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: kms_properties
results: parsing output: 5/ for test: kms_ccs
results: parsing output: 6/ for test: api_intel_allocator
results: parsing output: 7/ for test: gem_mmap
results: parsing output: 8/ for test: sw_sync
results: parsing output: 9/ for test: kms_cursor_legacy
results: parsing output: 10/ for test: gem_bad_reloc
results: parsing output: 11/ for test: perf_pmu
results: parsing output: 12/ for test: i915_fb_tiling
results: parsing output: 13/ for test: kms_cursor_crc
results: parsing output: 14/ for test: gem_mmap_gtt
results: parsing output: 15/ for test: kms_chamelium_color
results: parsing output: 16/ for test: kms_frontbuffer_tracking
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_tiled_partial_pwrite_pread
results: parsing output: 19/ for test: kms_frontbuffer_tracking
results: parsing output: 20/ for test: gem_exec_schedule
results: parsing output: 21/ for test: gem_mmap_gtt
results: parsing output: 22/ for test: kms_chamelium_frames
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: gem_softpin
results: parsing output: 25/ for test: gem_exec_balancer
results: parsing output: 26/ for test: kms_atomic
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_ctx_engines
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_cursor_crc
results: parsing output: 35/ for test: kms_psr2_sf
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: syncobj_wait
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: kms_color
results: parsing output: 40/ for test: gem_pread
results: parsing output: 41/ for test: perf
results: parsing output: 42/ for test: i915_suspend
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: syncobj_timeline
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_frontbuffer_tracking
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_psr
results: parsing output: 50/ for test: kms_flip_scaled_crc
results: parsing output: 51/ for test: gem_workarounds
results: parsing output: 52/ for test: syncobj_timeline
results: parsing output: 53/ for test: kms_flip_scaled_crc
results: parsing output: 54/ for test: gem_readwrite
results: parsing output: 55/ for test: gem_ctx_persistence
results: parsing output: 56/ for test: kms_busy
results: parsing output: 57/ for test: kms_big_fb
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_frontbuffer_tracking
results: parsing output: 60/ for test: kms_frontbuffer_tracking
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: sysfs_heartbeat_interval
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: kms_pm_dc
results: parsing output: 65/ for test: gen7_exec_parse
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_cursor_legacy
results: parsing output: 69/ for test: gem_exec_params
results: parsing output: 70/ for test: gem_workarounds
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: gem_userptr_blits
results: parsing output: 73/ for test: syncobj_wait
results: parsing output: 74/ for test: gem_exec_whisper
results: parsing output: 75/ for test: kms_frontbuffer_tracking
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: syncobj_wait
results: parsing output: 79/ for test: gem_fenced_exec_thrash
results: parsing output: 80/ for test: kms_plane_multiple
results: parsing output: 81/ for test: kms_vrr
results: parsing output: 82/ for test: gem_wait
results: parsing output: 83/ for test: kms_frontbuffer_tracking
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: gem_exec_whisper
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: gem_exec_fence
results: parsing output: 89/ for test: kms_psr
results: parsing output: 90/ for test: kms_flip
results: parsing output: 91/ for test: kms_plane
results: parsing output: 92/ for test: kms_draw_crc
results: parsing output: 93/ for test: gem_exec_balancer
results: parsing output: 94/ for test: syncobj_wait
results: parsing output: 95/ for test: gem_ppgtt
results: parsing output: 96/ for test: gem_exec_schedule
results: parsing output: 97/ for test: kms_frontbuffer_tracking
results: parsing output: 98/ for test: gem_exec_fence
results: parsing output: 99/ for test: i915_pm_rc6_residency
results: parsing output: 100/ for test: kms_flip
results: parsing output: 101/ for test: gem_exec_parallel
results: parsing output: 102/ for test: gem_exec_suspend
results: parsing output: 103/ for test: kms_lease
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: syncobj_wait
results: parsing output: 106/ for test: dumb_buffer
results: parsing output: 107/ for test: kms_invalid_mode
results: parsing output: 108/ for test: kms_vblank
results: parsing output: 109/ for test: kms_dp_link_training
results: parsing output: 110/ for test: gem_partial_pwrite_pread
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: kms_psr
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: gem_render_copy
results: parsing output: 118/ for test: tools_test
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_addfb_basic
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_frontbuffer_tracking
results: parsing output: 123/ for test: kms_dsc
results: parsing output: 124/ for test: gem_mmap_offset
results: parsing output: 125/ for test: kms_color_pipeline
results: parsing output: 126/ for test: kms_big_fb
results: parsing output: 127/ for test: kms_frontbuffer_tracking
results: parsing output: 128/ for test: kms_content_protection
results: parsing output: 129/ for test: vgem_basic
results: parsing output: 130/ for test: gem_render_copy
results: parsing output: 131/ for test: kms_rotation_crc
results: parsing output: 132/ for test: i915_drm_fdinfo
results: parsing output: 133/ for test: kms_frontbuffer_tracking
results: parsing output: 134/ for test: kms_lease
results: parsing output: 135/ for test: kms_frontbuffer_tracking
results: parsing output: 136/ for test: kms_ccs
results: parsing output: 137/ for test: syncobj_timeline
results: parsing output: 138/ for test: kms_psr2_sf
results: parsing output: 139/ for test: kms_frontbuffer_tracking
results: parsing output: 140/ for test: syncobj_timeline
results: parsing output: 141/ for test: drm_read
results: parsing output: 142/ for test: kms_frontbuffer_tracking
results: parsing output: 143/ for test: kms_frontbuffer_tracking
results: parsing output: 144/ for test: kms_big_fb
results: parsing output: 145/ for test: gem_exec_endless
results: parsing output: 146/ for test: api_intel_bb
results: parsing output: 147/ for test: gem_render_copy
results: parsing output: 148/ for test: kms_frontbuffer_tracking
results: parsing output: 149/ for test: kms_frontbuffer_tracking
results: parsing output: 150/ for test: kms_pm_rpm
results: parsing output: 151/ for test: kms_ccs
results: parsing output: 152/ for test: syncobj_eventfd
results: parsing output: 153/ for test: kms_plane
results: parsing output: 154/ for test: kms_rotation_crc
results: parsing output: 155/ for test: syncobj_wait
Done.