[56.454912] Initializing watchdogs [56.454960] /dev/watchdog0 [56.468972] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics] [56.473226] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.475471] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.478811] [001/130] (960s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-16bpp-xtile-downscaling) [56.634073] Starting subtest: flip-64bpp-xtile-to-16bpp-xtile-downscaling [56.636246] Starting dynamic subtest: pipe-A-default-mode [57.737064] Dynamic subtest pipe-A-default-mode: SKIP (1.103s) [57.741953] Subtest flip-64bpp-xtile-to-16bpp-xtile-downscaling: SKIP (1.104s) [57.895683] [002/130] (959s left) api_intel_bb (simple-bb) [57.959054] Starting subtest: simple-bb [57.963710] Subtest simple-bb: SUCCESS (0.006s) [58.081018] [003/130] (958s left) gem_exec_parallel (basic) [58.152840] Starting subtest: basic [58.155430] Starting dynamic subtest: rcs0 [59.605607] Dynamic subtest rcs0: SUCCESS (1.457s) [59.614684] Starting dynamic subtest: bcs0 [61.083072] Dynamic subtest bcs0: SUCCESS (1.482s) [61.092511] Starting dynamic subtest: vcs0 [62.890808] Dynamic subtest vcs0: SUCCESS (1.810s) [62.899939] Starting dynamic subtest: vcs1 [64.940647] Dynamic subtest vcs1: SUCCESS (2.053s) [64.949953] Starting dynamic subtest: vecs0 [66.922458] Dynamic subtest vecs0: SUCCESS (1.984s) [66.931961] Starting dynamic subtest: ccs0 [68.410614] Dynamic subtest ccs0: SUCCESS (1.491s) [68.413093] Subtest basic: SUCCESS (10.280s) [68.593195] [004/130] (948s left) kms_cursor_crc (cursor-random-32x32) [68.732584] Starting subtest: cursor-random-32x32 [68.776133] Subtest cursor-random-32x32: SKIP (0.038s) [69.072602] [005/130] (948s left) gem_ctx_persistence (engines-hostile-preempt) [69.141127] Starting subtest: engines-hostile-preempt [69.143595] Starting dynamic subtest: rcs0 [69.246668] Dynamic subtest rcs0: SUCCESS (0.105s) [69.256290] Starting dynamic subtest: bcs0 [69.306970] Dynamic subtest bcs0: SUCCESS (0.060s) [69.316240] Starting dynamic subtest: vcs0 [70.987822] Dynamic subtest vcs0: SUCCESS (1.679s) [71.000588] Starting dynamic subtest: vcs1 [72.918899] Dynamic subtest vcs1: SUCCESS (1.933s) [72.928068] Starting dynamic subtest: vecs0 [74.932871] Dynamic subtest vecs0: SUCCESS (2.014s) [74.941133] Starting dynamic subtest: ccs0 [75.010385] Dynamic subtest ccs0: SUCCESS (0.079s) [75.013184] Subtest engines-hostile-preempt: SUCCESS (5.873s) [75.081620] [006/130] (942s left) gem_exec_fence (syncobj-timeline-invalid-flags) [75.692102] Starting subtest: syncobj-timeline-invalid-flags [75.694882] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [76.987341] [FACT gem_exec_fence (syncobj-timeline-invalid-flags)] new: kernel.kmod_is_loaded.vgem: true [76.992718] [007/130] (940s left) i915_query (engine-info-invalid) [77.045416] Starting subtest: engine-info-invalid [77.047743] Subtest engine-info-invalid: SUCCESS (0.000s) [77.151699] [008/130] (940s left) gem_exec_schedule (preempt-contexts) [77.227197] Starting subtest: preempt-contexts [77.229279] Starting dynamic subtest: rcs0 [77.308407] Dynamic subtest rcs0: SUCCESS (0.088s) [77.317585] Starting dynamic subtest: bcs0 [77.392143] Dynamic subtest bcs0: SUCCESS (0.083s) [77.401132] Starting dynamic subtest: vcs0 [77.454608] Dynamic subtest vcs0: SUCCESS (0.061s) [77.467675] Starting dynamic subtest: vcs1 [77.515414] Dynamic subtest vcs1: SUCCESS (0.062s) [77.524081] Starting dynamic subtest: vecs0 [77.567353] Dynamic subtest vecs0: SUCCESS (0.052s) [77.574409] Starting dynamic subtest: ccs0 [77.638075] Dynamic subtest ccs0: SUCCESS (0.071s) [77.640494] Subtest preempt-contexts: SUCCESS (0.417s) [79.068519] [009/130] (938s left) gem_ringfill (basic-all) [84.910518] Starting subtest: basic-all [86.063841] Subtest basic-all: SUCCESS (1.155s) [86.216538] [010/130] (931s left) kms_chamelium_edid (hdmi-mode-timings) [86.614190] Subtest hdmi-mode-timings: SKIP (0.000s) [87.377603] [011/130] (929s left) gem_ppgtt (blt-vs-render-ctx0) [87.437235] Starting subtest: blt-vs-render-ctx0 [120.545521] Subtest blt-vs-render-ctx0: SUCCESS (33.108s) [120.691628] [012/130] (896s left) kms_cursor_legacy (cursora-vs-flipb-toggle) [120.854142] Starting subtest: cursorA-vs-flipB-toggle [120.858656] Subtest cursorA-vs-flipB-toggle: SKIP (0.001s) [120.946411] [013/130] (896s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-cpu) [121.062241] Starting subtest: psr-rgb565-draw-mmap-cpu [125.656183] Subtest psr-rgb565-draw-mmap-cpu: SUCCESS (4.596s) [125.773782] [014/130] (891s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-hflip) [125.875746] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-hflip [126.852119] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-hflip: SUCCESS (0.978s) [126.993867] [015/130] (890s left) kms_plane_cursor (primary) [127.099727] Starting subtest: primary [127.104424] Starting dynamic subtest: pipe-A-eDP-1-size-64 [129.869488] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.768s) [129.897477] Starting dynamic subtest: pipe-A-eDP-1-size-128 [132.648096] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.760s) [132.671054] Starting dynamic subtest: pipe-A-eDP-1-size-256 [135.428081] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.760s) [135.740177] Starting dynamic subtest: pipe-B-eDP-1-size-64 [139.219984] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.489s) [139.243881] Starting dynamic subtest: pipe-B-eDP-1-size-128 [142.030589] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.792s) [142.056667] Starting dynamic subtest: pipe-B-eDP-1-size-256 [144.897807] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.848s) [145.215665] Starting dynamic subtest: pipe-C-eDP-1-size-64 [148.314903] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.108s) [148.340527] Starting dynamic subtest: pipe-C-eDP-1-size-128 [150.725121] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.391s) [150.751344] Starting dynamic subtest: pipe-C-eDP-1-size-256 [153.170483] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.424s) [153.483290] Starting dynamic subtest: pipe-D-eDP-1-size-64 [156.616111] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.142s) [156.641462] Starting dynamic subtest: pipe-D-eDP-1-size-128 [159.018120] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.380s) [159.042520] Starting dynamic subtest: pipe-D-eDP-1-size-256 [161.439139] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.402s) [161.743030] Subtest primary: SUCCESS (34.641s) [162.535413] [016/130] (854s left) syncobj_wait (wait-for-submit-snapshot) [162.611692] Starting subtest: wait-for-submit-snapshot [162.693738] Subtest wait-for-submit-snapshot: SUCCESS (0.081s) [162.766939] [017/130] (854s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [162.869772] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [162.874181] Subtest yf-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [162.982314] [018/130] (854s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt) [163.082913] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt [167.615889] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.536s) [167.759015] [019/130] (849s left) gem_softpin (safe-alignment) [167.827210] Starting subtest: safe-alignment [167.846469] Subtest safe-alignment: SUCCESS (0.019s) [168.969366] [020/130] (848s left) kms_invalid_mode (bad-vtotal) [169.088449] Starting subtest: bad-vtotal [169.090881] Starting dynamic subtest: pipe-A-eDP-1 [169.371946] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s) [169.380040] Starting dynamic subtest: pipe-B-eDP-1 [169.382551] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [169.389770] Starting dynamic subtest: pipe-C-eDP-1 [169.392105] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [169.399198] Starting dynamic subtest: pipe-D-eDP-1 [169.401139] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [169.403073] Subtest bad-vtotal: SUCCESS (0.289s) [170.213802] [021/130] (847s left) kms_ccs (ccs-on-another-bo-yf-tiled-ccs) [170.315101] Starting subtest: ccs-on-another-bo-yf-tiled-ccs [170.317426] Starting dynamic subtest: pipe-A-eDP-1 [170.340989] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [170.348810] Starting dynamic subtest: pipe-B-eDP-1 [170.371263] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [170.378703] Starting dynamic subtest: pipe-C-eDP-1 [170.401095] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [170.409693] Starting dynamic subtest: pipe-D-eDP-1 [170.432110] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [170.436277] Subtest ccs-on-another-bo-yf-tiled-ccs: SKIP (0.004s) [172.471066] [022/130] (845s left) kms_cursor_crc (cursor-offscreen-512x170) [172.727671] Starting subtest: cursor-offscreen-512x170 [172.731796] Subtest cursor-offscreen-512x170: SKIP (0.001s) [172.887427] [023/130] (844s left) kms_plane_scaling (planes-downscale-factor-0-25) [172.982100] Starting subtest: planes-downscale-factor-0-25 [172.984377] Starting dynamic subtest: pipe-A [172.999448] Dynamic subtest pipe-A: SKIP (0.011s) [173.007684] Starting dynamic subtest: pipe-B [173.023274] Dynamic subtest pipe-B: SKIP (0.022s) [173.031983] Starting dynamic subtest: pipe-C [173.043930] Dynamic subtest pipe-C: SKIP (0.022s) [173.051145] Starting dynamic subtest: pipe-D [173.068801] Dynamic subtest pipe-D: SKIP (0.023s) [173.073254] Subtest planes-downscale-factor-0-25: SKIP (0.082s) [173.165316] [024/130] (844s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [173.268335] Starting subtest: crc-primary-basic-y-tiled-ccs [173.270707] Starting dynamic subtest: pipe-A-eDP-1 [173.293834] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [173.302960] Starting dynamic subtest: pipe-B-eDP-1 [173.325065] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [173.332923] Starting dynamic subtest: pipe-C-eDP-1 [173.355087] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [173.363122] Starting dynamic subtest: pipe-D-eDP-1 [173.385480] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [173.389677] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.005s) [175.424267] [025/130] (842s left) gem_eio (context-create) [175.664704] Starting subtest: context-create [176.011201] Subtest context-create: SUCCESS (0.346s) [176.160635] [026/130] (841s left) gem_pxp (hw-rejects-pxp-buffer) [176.288471] Starting subtest: hw-rejects-pxp-buffer [176.292680] Subtest hw-rejects-pxp-buffer: SKIP (0.000s) [176.405411] [027/130] (841s left) kms_flip (wf_vblank-ts-check-interruptible) [176.510982] Starting subtest: wf_vblank-ts-check-interruptible [176.515194] Starting dynamic subtest: A-eDP1 [185.468859] Dynamic subtest A-eDP1: SUCCESS (8.952s) [185.478142] Starting dynamic subtest: B-eDP1 [194.394172] Dynamic subtest B-eDP1: SUCCESS (8.924s) [194.407791] Starting dynamic subtest: C-eDP1 [203.302768] Dynamic subtest C-eDP1: SUCCESS (8.907s) [203.310634] Starting dynamic subtest: D-eDP1 [212.228237] Dynamic subtest D-eDP1: SUCCESS (8.925s) [212.234239] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.719s) [213.443135] [028/130] (804s left) gem_eio (in-flight-internal-10ms) [213.681062] Starting subtest: in-flight-internal-10ms [215.031519] Subtest in-flight-internal-10ms: SUCCESS (1.349s) [215.178334] [029/130] (802s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu) [215.274812] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu [219.811337] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SUCCESS (4.539s) [219.940929] [030/130] (798s left) syncobj_wait (invalid-reset-bad-pad) [219.994431] Starting subtest: invalid-reset-bad-pad [219.996866] Subtest invalid-reset-bad-pad: SUCCESS (0.000s) [220.095429] [031/130] (797s left) kms_frontbuffer_tracking (fbc-suspend) [220.205385] Starting subtest: fbc-suspend [258.796453] Subtest fbc-suspend: SUCCESS (8.922s) [260.928245] [032/130] (788s left) gem_exec_schedule (fairslice) [261.020400] Starting subtest: fairslice [261.023512] Starting dynamic subtest: rcs0 [263.035731] Dynamic subtest rcs0: SUCCESS (2.042s) [263.046060] Starting dynamic subtest: bcs0 [265.063544] Dynamic subtest bcs0: SUCCESS (2.040s) [265.074726] Starting dynamic subtest: vcs0 [267.078141] Dynamic subtest vcs0: SUCCESS (2.028s) [267.087279] Starting dynamic subtest: vcs1 [269.099728] Dynamic subtest vcs1: SUCCESS (2.027s) [269.109862] Starting dynamic subtest: vecs0 [271.121353] Dynamic subtest vecs0: SUCCESS (2.026s) [271.132356] Starting dynamic subtest: ccs0 [273.138019] Dynamic subtest ccs0: SUCCESS (2.024s) [273.140583] Subtest fairslice: SUCCESS (12.193s) [273.436751] [033/130] (776s left) kms_psr (fbc-pr-sprite-mmap-gtt) [273.539557] Starting subtest: fbc-pr-sprite-mmap-gtt [273.544519] Subtest fbc-pr-sprite-mmap-gtt: SKIP (0.000s) [273.605271] [034/130] (776s left) drm_fdinfo (all-busy-idle-check-all) [273.648717] Starting subtest: all-busy-idle-check-all [273.656296] Subtest all-busy-idle-check-all: SKIP (0.005s) [273.719373] [035/130] (776s left) gem_exec_params (dr1-dirt) [273.823517] Starting subtest: DR1-dirt [273.826438] Subtest DR1-dirt: SUCCESS (0.000s) [273.916432] [036/130] (775s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area) [278.921768] Starting subtest: psr2-primary-plane-update-sf-dmg-area [278.924649] Starting dynamic subtest: pipe-A-eDP-1 [285.515329] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.603s) [285.525234] Starting dynamic subtest: pipe-B-eDP-1 [292.134596] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.619s) [292.137220] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.226s) [292.997135] [037/130] (756s left) gem_workarounds (basic-read-context) [293.078713] Starting subtest: basic-read-context [293.089996] Subtest basic-read-context: SUCCESS (0.010s) [293.204121] [038/130] (756s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-wc) [293.319539] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-wc [293.324540] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [293.397549] [039/130] (756s left) kms_rotation_crc (primary-y-tiled-reflect-x-270) [293.491285] Starting subtest: primary-y-tiled-reflect-x-270 [293.496574] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s) [293.569041] [040/130] (756s left) gem_userptr_blits (create-destroy-sync) [293.642254] Starting subtest: create-destroy-sync [298.656323] Subtest create-destroy-sync: SUCCESS (5.017s) [298.800857] [041/130] (751s left) syncobj_timeline (multi-wait-submitted-signaled) [298.862752] Starting subtest: multi-wait-submitted-signaled [298.865305] Subtest multi-wait-submitted-signaled: SUCCESS (0.001s) [298.962029] [042/130] (751s left) kms_pm_dc (dc5-psr) [300.067611] Starting subtest: dc5-psr [303.040684] Subtest dc5-psr: SUCCESS (2.974s) [303.914089] [043/130] (746s left) gem_lmem_evict (dontneed-evict-race) [303.966546] Subtest dontneed-evict-race: SKIP (0.000s) [304.005167] [044/130] (746s left) kms_flip (flip-vs-rmfb) [304.099644] Starting subtest: flip-vs-rmfb [304.102412] Starting dynamic subtest: A-eDP1 [312.794610] Dynamic subtest A-eDP1: SUCCESS (8.699s) [312.803357] Starting dynamic subtest: B-eDP1 [321.514375] Dynamic subtest B-eDP1: SUCCESS (8.723s) [321.524592] Starting dynamic subtest: C-eDP1 [330.253570] Dynamic subtest C-eDP1: SUCCESS (8.743s) [330.262341] Starting dynamic subtest: D-eDP1 [338.978710] Dynamic subtest D-eDP1: SUCCESS (8.728s) [338.981374] Subtest flip-vs-rmfb: SUCCESS (34.901s) [340.218102] [045/130] (709s left) kms_writeback (writeback-pixel-formats) [340.319583] Subtest writeback-pixel-formats: SKIP (0.000s) [340.362088] [046/130] (709s left) prime_vgem (basic-fence-mmap) [340.436022] Starting subtest: basic-fence-mmap [340.441472] Subtest basic-fence-mmap: SKIP (0.000s) [340.532216] [047/130] (709s left) kms_psr (psr2-cursor-mmap-gtt) [340.634575] Starting subtest: psr2-cursor-mmap-gtt [340.637401] Starting dynamic subtest: eDP-1 [342.290187] Dynamic subtest eDP-1: SUCCESS (1.658s) [342.292547] Subtest psr2-cursor-mmap-gtt: SUCCESS (1.659s) [343.069716] [048/130] (707s left) gem_ctx_param (basic-default) [343.123538] Starting subtest: basic-default [343.126508] Subtest basic-default: SUCCESS (0.000s) [343.197063] [049/130] (707s left) kms_ccs (crc-primary-suspend-y-tiled-ccs) [343.295725] Starting subtest: crc-primary-suspend-y-tiled-ccs [343.298159] Starting dynamic subtest: pipe-A-eDP-1 [343.307317] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [343.316182] Starting dynamic subtest: pipe-B-eDP-1 [343.326235] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [343.336133] Starting dynamic subtest: pipe-C-eDP-1 [343.346204] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [343.355477] Starting dynamic subtest: pipe-D-eDP-1 [343.365992] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [343.371200] Subtest crc-primary-suspend-y-tiled-ccs: SKIP (0.004s) [345.418774] [050/130] (704s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0-hflip) [345.528310] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0-hflip [346.750419] Subtest x-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.222s) [346.888018] [051/130] (703s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [346.998746] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt [347.003010] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [347.099858] [052/130] (703s left) gem_exec_reloc (basic-write-wc-active) [347.160655] Subtest basic-write-wc-active: SKIP (0.000s) [347.227123] [053/130] (703s left) gem_exec_whisper (basic-sync) [347.303657] Starting subtest: basic-sync [354.648774] Subtest basic-sync: SUCCESS (7.342s) [354.831497] [054/130] (695s left) perf (blocking) [354.963447] Starting subtest: blocking [354.965732] Starting dynamic subtest: 0-rcs0 [365.006725] Dynamic subtest 0-rcs0: SUCCESS (10.020s) [365.015573] Starting dynamic subtest: 1-vecs0 [375.041245] Dynamic subtest 1-vecs0: SUCCESS (10.022s) [375.044058] Subtest blocking: SUCCESS (20.044s) [375.087909] [055/130] (675s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [380.112563] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [380.118266] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s) [380.957612] [056/130] (669s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-wc) [381.070586] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-wc [381.075826] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [381.177292] [057/130] (669s left) gem_set_tiling_vs_pwrite [381.298983] [058/130] (669s left) kms_legacy_colorkey (invalid-plane) [381.408413] Starting subtest: invalid-plane [381.411085] Starting dynamic subtest: zero-id [381.413626] Dynamic subtest zero-id: SUCCESS (0.000s) [381.423183] Starting dynamic subtest: outrange-id [381.425667] Dynamic subtest outrange-id: SUCCESS (0.000s) [381.428537] Subtest invalid-plane: SUCCESS (0.001s) [381.479402] [059/130] (669s left) kms_vblank (invalid) [381.582713] Starting subtest: invalid [381.585210] Starting dynamic subtest: pipe-A-eDP-1 [382.001576] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.419s) [382.004506] Subtest invalid: SUCCESS (0.420s) [382.787393] [060/130] (667s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs) [382.886394] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs [382.888952] Starting dynamic subtest: pipe-A-eDP-1 [382.912617] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [382.921740] Starting dynamic subtest: pipe-B-eDP-1 [382.945267] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [382.953710] Starting dynamic subtest: pipe-C-eDP-1 [382.977509] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [382.986391] Starting dynamic subtest: pipe-D-eDP-1 [383.011577] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [383.014118] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs: SUCCESS (0.005s) [385.040060] [061/130] (665s left) prime_vgem (basic-gtt) [385.129607] Starting subtest: basic-gtt [385.135528] Subtest basic-gtt: SKIP (0.000s) [385.230889] [062/130] (665s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [385.333446] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [385.338500] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [385.431829] [063/130] (665s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-pwrite) [385.531586] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-pwrite [385.537418] Subtest fbc-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [385.633887] [064/130] (665s left) kms_big_fb (linear-8bpp-rotate-270) [385.734048] Starting subtest: linear-8bpp-rotate-270 [385.755713] Subtest linear-8bpp-rotate-270: SKIP (0.021s) [385.886615] [065/130] (664s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [385.989310] Starting subtest: yf-tiled-32bpp-rotate-180 [385.993534] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [386.103110] [066/130] (664s left) perf (gen12-oa-tlb-invalidate) [386.182370] Starting subtest: gen12-oa-tlb-invalidate [386.184714] Starting dynamic subtest: 0-rcs0 [396.239098] Dynamic subtest 0-rcs0: SUCCESS (10.052s) [396.249491] Starting dynamic subtest: 1-vcs0 [406.288064] Dynamic subtest 1-vcs0: SUCCESS (10.047s) [406.290727] Subtest gen12-oa-tlb-invalidate: SUCCESS (20.101s) [406.333945] [067/130] (644s left) gem_vm_create (isolation) [406.387006] Starting subtest: isolation [406.398039] Subtest isolation: SUCCESS (0.011s) [406.525194] [068/130] (644s left) kms_addfb_basic (clobberred-modifier) [406.580142] Starting subtest: clobberred-modifier [406.585481] Subtest clobberred-modifier: SKIP (0.000s) [406.727092] [069/130] (644s left) gem_ctx_exec (basic-nohangcheck) [406.792565] Starting subtest: basic-nohangcheck [407.045276] Subtest basic-nohangcheck: SUCCESS (0.255s) [407.178536] [070/130] (643s left) kms_chamelium_frames (hdmi-crc-single) [407.577070] Subtest hdmi-crc-single: SKIP (0.000s) [408.357156] [071/130] (642s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [408.472959] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [408.477961] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [408.564421] [072/130] (642s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [408.660501] Starting subtest: fbc-indfb-scaledprimary [412.760057] Subtest fbc-indfb-scaledprimary: SUCCESS (4.104s) [412.895083] [073/130] (638s left) kms_async_flips (alternate-sync-async-flip-atomic) [413.003863] Starting subtest: alternate-sync-async-flip-atomic [413.371331] Starting dynamic subtest: pipe-A-eDP-1 [416.186457] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.817s) [416.558355] Starting dynamic subtest: pipe-B-eDP-1 [419.308396] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.759s) [419.678467] Starting dynamic subtest: pipe-C-eDP-1 [422.434308] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.767s) [422.802715] Starting dynamic subtest: pipe-D-eDP-1 [425.556840] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.764s) [425.558946] Subtest alternate-sync-async-flip-atomic: SUCCESS (12.556s) [426.716338] [074/130] (624s left) kms_dp_link_training (uhbr-sst) [426.819704] Starting subtest: uhbr-sst [426.831345] Subtest uhbr-sst: SKIP (0.000s) [426.890117] [075/130] (624s left) kms_psr (psr2-sprite-plane-move) [426.999637] Starting subtest: psr2-sprite-plane-move [427.002274] Starting dynamic subtest: eDP-1 [428.740360] Dynamic subtest eDP-1: SUCCESS (1.740s) [428.743339] Subtest psr2-sprite-plane-move: SUCCESS (1.741s) [429.572985] [076/130] (621s left) gem_render_copy (linear-to-vebox-yf-tiled) [429.635989] Starting subtest: linear-to-vebox-yf-tiled [429.641721] Subtest linear-to-vebox-yf-tiled: SKIP (0.000s) [429.816029] [077/130] (621s left) kms_cursor_legacy (short-busy-flip-before-cursor-atomic-transitions-varying-s [429.951422] Starting subtest: short-busy-flip-before-cursor-atomic-transitions-varying-size [429.956372] Subtest short-busy-flip-before-cursor-atomic-transitions-varying-size: SKIP (0.000s) [430.045802] [078/130] (621s left) i915_pm_rc6_residency (media-rc6-accuracy) [430.111422] Starting subtest: media-rc6-accuracy [430.116545] Subtest media-rc6-accuracy: SKIP (0.000s) [430.193201] [079/130] (621s left) kms_frontbuffer_tracking (fbc-rgb565-draw-render) [430.303138] Starting subtest: fbc-rgb565-draw-render [433.529768] Subtest fbc-rgb565-draw-render: SUCCESS (3.231s) [433.640247] [080/130] (617s left) kms_ccs (random-ccs-data-y-tiled-ccs) [433.737060] Starting subtest: random-ccs-data-y-tiled-ccs [433.739129] Starting dynamic subtest: pipe-A-eDP-1 [433.762174] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [433.771222] Starting dynamic subtest: pipe-B-eDP-1 [433.795498] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [433.804561] Starting dynamic subtest: pipe-C-eDP-1 [433.829454] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [433.838766] Starting dynamic subtest: pipe-D-eDP-1 [433.864120] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [433.868628] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.004s) [435.854427] [081/130] (615s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu) [435.959968] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu [435.965343] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [436.044204] [082/130] (615s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted) [436.100276] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted [436.103316] Subtest invalid-multi-wait-all-unsubmitted-submitted: SUCCESS (0.000s) [436.199089] [083/130] (615s left) gem_busy (close-race) [436.276747] Starting subtest: close-race [459.604008] Subtest close-race: SUCCESS (23.326s) [459.934867] [084/130] (591s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [460.083708] Starting subtest: fbc-modesetfrombusy [462.880850] Subtest fbc-modesetfrombusy: SUCCESS (2.802s) [463.015756] [085/130] (588s left) kms_plane (plane-panning-bottom-right-suspend) [463.127500] Starting subtest: plane-panning-bottom-right-suspend [463.132383] Starting dynamic subtest: pipe-A [481.012874] Dynamic subtest pipe-A: SUCCESS (2.920s) [481.022903] Starting dynamic subtest: pipe-B [498.941933] Dynamic subtest pipe-B: SUCCESS (3.385s) [498.945324] Subtest plane-panning-bottom-right-suspend: SUCCESS (6.310s) [499.794271] [086/130] (581s left) kms_properties (invalid-properties-legacy) [499.902180] Starting subtest: invalid-properties-legacy [500.009020] Subtest invalid-properties-legacy: SUCCESS (0.109s) [500.076524] [087/130] (581s left) kms_cursor_legacy (flip-vs-cursor-crc-atomic) [500.196784] Starting subtest: flip-vs-cursor-crc-atomic [500.850758] Subtest flip-vs-cursor-crc-atomic: SUCCESS (0.658s) [501.706705] [088/130] (579s left) kms_cursor_crc (cursor-rapid-movement-32x32) [501.853098] Starting subtest: cursor-rapid-movement-32x32 [501.893277] Subtest cursor-rapid-movement-32x32: SKIP (0.033s) [502.185494] [089/130] (579s left) kms_pm_lpsp (screens-disabled) [503.298038] Starting subtest: screens-disabled [503.303628] Subtest screens-disabled: SKIP (0.000s) [503.365463] [090/130] (577s left) syncobj_timeline (wait-all-for-submit-delayed-submit) [503.436846] Starting subtest: wait-all-for-submit-delayed-submit [503.539552] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s) [503.611755] [091/130] (577s left) gem_userptr_blits (dmabuf-sync) [503.684818] Starting subtest: dmabuf-sync [503.689703] Subtest dmabuf-sync: SKIP (0.003s) [503.813689] [092/130] (577s left) kms_addfb_basic (unused-modifier) [503.869581] Starting subtest: unused-modifier [503.873724] Subtest unused-modifier: SUCCESS (0.000s) [504.003700] [093/130] (577s left) gem_render_copy (y-tiled-ccs-to-linear) [504.074922] Starting subtest: y-tiled-ccs-to-linear [504.080589] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [504.252016] [094/130] (577s left) kms_feature_discovery (display-2x) [504.355836] Starting subtest: display-2x [504.360393] Subtest display-2x: SKIP (0.000s) [504.423572] [095/130] (576s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-blt) [504.530694] Starting subtest: psr-2p-primscrn-cur-indfb-draw-blt [504.534872] Subtest psr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [504.618491] [096/130] (576s left) kms_frontbuffer_tracking (fbc-1p-offscren-pri-indfb-draw-mmap-wc) [504.716458] Starting subtest: fbc-1p-offscren-pri-indfb-draw-mmap-wc [507.758279] Subtest fbc-1p-offscren-pri-indfb-draw-mmap-wc: SUCCESS (3.057s) [507.873198] [097/130] (573s left) kms_color (ctm-green-to-red) [507.981642] Starting subtest: ctm-green-to-red [507.984271] Starting dynamic subtest: pipe-A-eDP-1 [508.682298] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [508.694642] Starting dynamic subtest: pipe-B-eDP-1 [510.074778] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.396s) [510.084998] Starting dynamic subtest: pipe-C-eDP-1 [511.347791] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.276s) [511.359493] Starting dynamic subtest: pipe-D-eDP-1 [512.679643] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.332s) [512.682287] Subtest ctm-green-to-red: SUCCESS (4.706s) [513.508593] [098/130] (567s left) kms_psr (pr-basic) [513.597492] Starting subtest: pr-basic [513.602725] Subtest pr-basic: SKIP (0.000s) [513.667014] [099/130] (567s left) kms_frontbuffer_tracking (fbc-tiling-4) [513.767052] Starting subtest: fbc-tiling-4 [517.002550] Subtest fbc-tiling-4: SUCCESS (3.246s) [517.150418] [100/130] (564s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-render) [517.259075] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-render [517.263443] Subtest psr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [517.349516] [101/130] (564s left) gem_mmap (bad-size) [517.407181] Subtest bad-size: SKIP (0.000s) [517.458113] [102/130] (564s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [522.476905] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [522.482531] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.002s) [523.323558] [103/130] (558s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-render) [523.430810] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-render [523.435905] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-render: SKIP (0.000s) [523.543807] [104/130] (558s left) kms_getfb (getfb-handle-zero) [523.604553] Starting subtest: getfb-handle-zero [523.607040] Subtest getfb-handle-zero: SUCCESS (0.000s) [523.709375] [105/130] (558s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset) [523.807735] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset [523.810340] Starting dynamic subtest: A-eDP1 [527.435652] Dynamic subtest A-eDP1: SUCCESS (3.627s) [527.445695] Starting dynamic subtest: B-eDP1 [530.613012] Dynamic subtest B-eDP1: SUCCESS (3.180s) [530.622015] Starting dynamic subtest: C-eDP1 [533.680628] Dynamic subtest C-eDP1: SUCCESS (3.066s) [533.689846] Starting dynamic subtest: D-eDP1 [536.772716] Dynamic subtest D-eDP1: SUCCESS (3.091s) [536.775435] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (12.972s) [537.563628] [106/130] (544s left) gem_exec_schedule (u-semaphore-user) [537.652850] Starting subtest: u-semaphore-user [537.701043] Subtest u-semaphore-user: SUCCESS (0.058s) [539.155390] [107/130] (542s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-pgflip-blt) [539.271596] Starting subtest: psr-1p-primscrn-shrfb-pgflip-blt [544.497910] Subtest psr-1p-primscrn-shrfb-pgflip-blt: SUCCESS (5.230s) [544.624177] [108/130] (537s left) gem_exec_params (secure-non-master) [544.701885] Starting subtest: secure-non-master [544.707805] Subtest secure-non-master: SKIP (0.000s) [544.801802] [109/130] (537s left) gen9_exec_parse (unaligned-access) [544.865793] Subtest unaligned-access: SKIP (0.000s) [544.955451] [110/130] (536s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted) [545.018751] Starting subtest: multi-wait-available-unsubmitted-submitted [545.020939] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s) [545.128419] [111/130] (536s left) drm_fdinfo (virtual-busy-hang) [545.169028] Starting subtest: virtual-busy-hang [545.174668] Subtest virtual-busy-hang: SKIP (0.000s) [545.236499] [112/130] (536s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [545.300223] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [545.390852] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.027s) [545.424260] [113/130] (536s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [545.521889] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [545.526466] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [545.631650] [114/130] (536s left) kms_rotation_crc (primary-4-tiled-reflect-x-0) [545.733462] Starting subtest: primary-4-tiled-reflect-x-0 [553.008920] Subtest primary-4-tiled-reflect-x-0: SUCCESS (7.274s) [554.165220] [115/130] (527s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling) [554.262447] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling [554.265017] Starting dynamic subtest: pipe-A-default-mode [554.548848] Dynamic subtest pipe-A-default-mode: SKIP (0.281s) [554.553782] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.283s) [555.391660] [116/130] (526s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [555.521927] Starting subtest: basic-flip-after-cursor-legacy [556.441166] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.918s) [557.308539] [117/130] (524s left) gem_exec_fence (long-history) [557.751777] Starting subtest: long-history [564.921490] Subtest long-history: SUCCESS (7.172s) [565.542367] [118/130] (516s left) kms_atomic_transition (modeset-transition-fencing) [565.649772] Starting subtest: modeset-transition-fencing [565.651875] Starting dynamic subtest: 1x-outputs [576.083247] Dynamic subtest 1x-outputs: SUCCESS (10.438s) [576.344182] Subtest modeset-transition-fencing: SUCCESS (10.700s) [577.200265] [119/130] (505s left) api_intel_bb (delta-check) [577.255245] Starting subtest: delta-check [577.257623] Subtest delta-check: SUCCESS (0.006s) [577.401424] [120/130] (504s left) perf (polling-parameterized) [577.497722] Starting subtest: polling-parameterized [597.527054] Subtest polling-parameterized: SUCCESS (20.034s) [597.573941] [121/130] (484s left) kms_pwrite_crc [599.227117] [122/130] (483s left) kms_flip (flip-vs-expired-vblank) [599.333028] Starting subtest: flip-vs-expired-vblank [599.335753] Starting dynamic subtest: A-eDP1 [608.037456] Dynamic subtest A-eDP1: SUCCESS (8.700s) [608.048036] Starting dynamic subtest: B-eDP1 [616.769685] Dynamic subtest B-eDP1: SUCCESS (8.729s) [616.781987] Starting dynamic subtest: C-eDP1 [625.485620] Dynamic subtest C-eDP1: SUCCESS (8.713s) [625.494500] Starting dynamic subtest: D-eDP1 [634.214804] Dynamic subtest D-eDP1: SUCCESS (8.727s) [634.221699] Subtest flip-vs-expired-vblank: SUCCESS (34.880s) [635.379289] [123/130] (447s left) syncobj_timeline (etime-multi-wait-for-submit-unsubmitted) [635.439226] Starting subtest: etime-multi-wait-for-submit-unsubmitted [635.546239] Subtest etime-multi-wait-for-submit-unsubmitted: SUCCESS (0.108s) [635.619049] [124/130] (446s left) i915_query (query-topology-garbage-items) [635.676031] Starting subtest: query-topology-garbage-items [635.679007] Subtest query-topology-garbage-items: SUCCESS (0.000s) [635.769652] [125/130] (446s left) gem_exec_balancer (full-late) [635.842275] Starting subtest: full-late [640.873904] Subtest full-late: SUCCESS (5.032s) [641.205027] [126/130] (441s left) gem_mmap_offset (bad-object) [641.269089] Starting subtest: bad-object [641.271854] Subtest bad-object: SUCCESS (0.001s) [641.355668] [127/130] (441s left) kms_busy (extended-modeset-hang-newfb) [641.461748] Starting subtest: extended-modeset-hang-newfb [641.464325] Starting dynamic subtest: pipe-A [676.050732] Dynamic subtest pipe-A: SUCCESS (34.590s) [676.060366] Starting dynamic subtest: pipe-D [698.971587] Dynamic subtest pipe-D: SUCCESS (22.925s) [698.974207] Subtest extended-modeset-hang-newfb: SUCCESS (57.520s) [699.753273] [128/130] (382s left) gem_ctx_shared (q-out-order) [699.822782] Starting subtest: Q-out-order [699.825521] Starting dynamic subtest: rcs0 [699.927519] Dynamic subtest rcs0: SUCCESS (0.104s) [699.946561] Starting dynamic subtest: vcs0 [700.003646] Dynamic subtest vcs0: SUCCESS (0.075s) [700.017902] Starting dynamic subtest: vcs1 [700.076410] Dynamic subtest vcs1: SUCCESS (0.071s) [700.094512] Starting dynamic subtest: vecs0 [700.151538] Dynamic subtest vecs0: SUCCESS (0.075s) [700.163935] Starting dynamic subtest: ccs0 [700.233518] Dynamic subtest ccs0: SUCCESS (0.082s) [700.235734] Subtest Q-out-order: SUCCESS (0.412s) [701.201473] [129/130] (381s left) gem_create (busy-create) [701.257609] Starting subtest: busy-create [701.260723] Starting dynamic subtest: smem0 [734.166708] Dynamic subtest smem0: SUCCESS (32.908s) [734.169835] Subtest busy-create: SUCCESS (32.909s) [734.350348] [130/130] (348s left) kms_psr (fbc-psr2-cursor-plane-move) [734.461916] Starting subtest: fbc-psr2-cursor-plane-move [734.464830] Starting dynamic subtest: eDP-1 [734.470013] Dynamic subtest eDP-1: SKIP (0.000s) [734.475676] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [734.527192] Closing watchdogs Done.