[747.695317] Initializing watchdogs
[747.695364]   /dev/watchdog0
[747.711439] [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]
[747.717433] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[747.719758] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[747.720158] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[747.723800] [001/131] (960s left) kms_frontbuffer_tracking (psr-1p-primscrn-shrfb-msflip-blt)
[747.848357] Starting subtest: psr-1p-primscrn-shrfb-msflip-blt
[755.067459] Subtest psr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.219s)
[755.208187] [002/131] (953s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[755.324707] Starting subtest: psr-2p-scndscrn-spr-indfb-draw-mmap-wc
[755.329832] Subtest psr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[755.455206] [003/131] (952s left) vgem_basic (dmabuf-fence)
[755.505421] Starting subtest: dmabuf-fence
[755.507617] Subtest dmabuf-fence: SUCCESS (0.000s)
[755.592751] [004/131] (952s left) gem_mmap_offset (perf)
[755.660168] Starting subtest: perf
[755.662719] Starting dynamic subtest: smem0
[756.017202] Dynamic subtest smem0: SUCCESS (0.356s)
[756.019837] Subtest perf: SUCCESS (0.357s)
[756.181573] [005/131] (952s left) kms_psr (psr2-sprite-mmap-cpu)
[756.284073] Starting subtest: psr2-sprite-mmap-cpu
[756.286405] Starting dynamic subtest: eDP-1
[758.004935] Dynamic subtest eDP-1: SUCCESS (1.720s)
[758.007623] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.722s)
[758.892371] [006/131] (949s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[758.952589] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[759.018298] [007/131] (949s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area)
[764.062565] Starting subtest: fbc-psr2-plane-move-sf-dmg-area
[764.065299] Starting dynamic subtest: pipe-A-eDP-1
[764.842739] Dynamic subtest pipe-A-eDP-1: SKIP (0.774s)
[764.853059] Starting dynamic subtest: pipe-B-eDP-1
[765.973401] Dynamic subtest pipe-B-eDP-1: SKIP (1.129s)
[765.978547] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (1.907s)
[767.188242] [008/131] (941s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt)
[767.292545] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt
[767.297561] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[767.402972] [009/131] (941s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-wc)
[767.503745] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-wc
[773.949811] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.450s)
[774.088783] [010/131] (934s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-onoff)
[774.195935] Starting subtest: psr-2p-primscrn-cur-indfb-onoff
[774.201354] Subtest psr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[774.315206] [011/131] (934s left) kms_big_fb (linear-8bpp-rotate-90)
[774.423342] Starting subtest: linear-8bpp-rotate-90
[774.444438] Subtest linear-8bpp-rotate-90: SKIP (0.020s)
[774.597167] [012/131] (934s left) kms_plane_multiple (2x-tiling-y)
[774.695898] Starting subtest: 2x-tiling-y
[774.700692] Subtest 2x-tiling-y: SKIP (0.000s)
[774.791452] [013/131] (933s left) gem_ctx_isolation (preservation-s3)
[774.850510] Starting subtest: preservation-S3
[774.853480] Starting dynamic subtest: rcs0
[790.666460] Dynamic subtest rcs0: SUCCESS (1.319s)
[790.676319] Starting dynamic subtest: bcs0
[806.694208] Dynamic subtest bcs0: SUCCESS (1.369s)
[806.706928] Starting dynamic subtest: vcs0
[822.702616] Dynamic subtest vcs0: SUCCESS (2.814s)
[822.713675] Starting dynamic subtest: vcs1
[840.689859] Dynamic subtest vcs1: SUCCESS (4.995s)
[840.701158] Starting dynamic subtest: vecs0
[858.697883] Dynamic subtest vecs0: SUCCESS (5.017s)
[858.708835] Starting dynamic subtest: ccs0
[876.684274] Dynamic subtest ccs0: SUCCESS (3.218s)
[876.686544] Subtest preservation-S3: SUCCESS (18.737s)
[876.958714] [014/131] (831s left) gem_exec_reloc (basic-wc-noreloc)
[877.021994] Subtest basic-wc-noreloc: SKIP (0.000s)
[877.100554] [015/131] (831s left) kms_fence_pin_leak
[877.268361] [016/131] (831s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-y-tiled)
[877.334659] Starting subtest: y-tiled-mc-ccs-to-vebox-y-tiled
[877.338963] Subtest y-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[877.537031] [017/131] (831s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[877.642207] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[877.644551] Starting dynamic subtest: pipe-A-eDP-1
[877.668901] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[877.680178] Starting dynamic subtest: pipe-B-eDP-1
[877.702933] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[877.711938] Starting dynamic subtest: pipe-C-eDP-1
[877.734423] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[877.743613] Starting dynamic subtest: pipe-D-eDP-1
[877.766656] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[877.770546] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[879.807838] [018/131] (829s left) kms_big_fb (yf-tiled-32bpp-rotate-180)
[879.908736] Starting subtest: yf-tiled-32bpp-rotate-180
[879.912951] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s)
[880.021315] [019/131] (828s left) gem_softpin (overlap)
[880.081556] Starting subtest: overlap
[880.991445] Subtest overlap: SUCCESS (0.910s)
[881.151116] [020/131] (827s left) gem_exec_fence (nb-await)
[881.326126] Starting subtest: nb-await
[881.328602] Starting dynamic subtest: rcs0
[881.396463] Dynamic subtest rcs0: SUCCESS (0.070s)
[881.414925] Starting dynamic subtest: bcs0
[881.453095] Dynamic subtest bcs0: SUCCESS (0.055s)
[881.464834] Starting dynamic subtest: vcs0
[881.511888] Dynamic subtest vcs0: SUCCESS (0.057s)
[881.523421] Starting dynamic subtest: vcs1
[881.571172] Dynamic subtest vcs1: SUCCESS (0.057s)
[881.582460] Starting dynamic subtest: vecs0
[881.628910] Dynamic subtest vecs0: SUCCESS (0.056s)
[881.640965] Starting dynamic subtest: ccs0
[881.686942] Dynamic subtest ccs0: SUCCESS (0.056s)
[881.689531] Subtest nb-await: SUCCESS (0.363s)
[883.516781] [021/131] (825s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[883.623024] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[883.627395] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[883.748024] [022/131] (825s left) syncobj_wait (invalid-signal-bad-pad)
[883.805218] Starting subtest: invalid-signal-bad-pad
[883.807119] Subtest invalid-signal-bad-pad: SUCCESS (0.000s)
[883.934366] [023/131] (825s left) kms_cursor_legacy (modeset-atomic-cursor-hotspot)
[884.059875] Starting subtest: modeset-atomic-cursor-hotspot
[884.064498] Subtest modeset-atomic-cursor-hotspot: SKIP (0.000s)
[884.246513] [024/131] (824s left) drm_mm (drm_mm)
[884.283338] Starting subtest: drm_mm
[884.291589] Starting dynamic subtest: drm_test_mm_init
[884.419346] Dynamic subtest drm_test_mm_init: SUCCESS (0.125s)
[884.429847] Starting dynamic subtest: drm_test_mm_debug
[884.547525] Dynamic subtest drm_test_mm_debug: SUCCESS (0.129s)
[884.558625] Starting dynamic subtest: drm_test_mm_align32
[884.678318] Dynamic subtest drm_test_mm_align32: SUCCESS (0.130s)
[884.689269] Starting dynamic subtest: drm_test_mm_align64
[884.832221] Dynamic subtest drm_test_mm_align64: SUCCESS (0.153s)
[884.843878] Starting dynamic subtest: drm_test_mm_lowest
[884.973285] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.139s)
[884.984137] Starting dynamic subtest: drm_test_mm_highest
[885.136195] Dynamic subtest drm_test_mm_highest: SUCCESS (0.164s)
[885.138535] Subtest drm_mm: SUCCESS (0.854s)
[885.364704] [025/131] (823s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[885.473078] Starting subtest: invalid-modeset-force-ultra-joiner
[885.477574] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[885.559319] [026/131] (823s left) gem_userptr_blits (nohangcheck)
[885.636851] Starting subtest: nohangcheck
[885.888047] Subtest nohangcheck: SUCCESS (0.248s)
[886.020800] [027/131] (823s left) gem_lmem_swapping (parallel-multi)
[886.061042] Subtest parallel-multi: SKIP (0.000s)
[886.106004] [028/131] (823s left) kms_psr (fbc-psr-primary-render)
[886.195517] Starting subtest: fbc-psr-primary-render
[886.197647] Starting dynamic subtest: eDP-1
[886.201962] Dynamic subtest eDP-1: SKIP (0.000s)
[886.206270] Subtest fbc-psr-primary-render: SKIP (0.001s)
[886.296881] [029/131] (823s left) gem_spin_batch (legacy)
[886.361481] Starting subtest: legacy
[886.363868] Starting dynamic subtest: default
[889.600366] Dynamic subtest default: SUCCESS (3.234s)
[889.612805] Starting dynamic subtest: render
[892.833585] Dynamic subtest render: SUCCESS (3.231s)
[892.845655] Starting dynamic subtest: bsd
[896.071299] Dynamic subtest bsd: SUCCESS (3.235s)
[896.083942] Starting dynamic subtest: bsd1
[899.307595] Dynamic subtest bsd1: SUCCESS (3.234s)
[899.319445] Starting dynamic subtest: bsd2
[902.540771] Dynamic subtest bsd2: SUCCESS (3.231s)
[902.552569] Starting dynamic subtest: blt
[905.777478] Dynamic subtest blt: SUCCESS (3.234s)
[905.789945] Starting dynamic subtest: vebox
[909.013326] Dynamic subtest vebox: SUCCESS (3.233s)
[909.015719] Subtest legacy: SUCCESS (22.651s)
[909.491498] [030/131] (799s left) i915_drm_fdinfo (virtual-idle)
[909.528984] Starting subtest: virtual-idle
[912.607680] Subtest virtual-idle: SUCCESS (3.080s)
[912.708667] [031/131] (796s left) syncobj_wait (wait-all-for-submit-delayed-submit)
[912.768654] Starting subtest: wait-all-for-submit-delayed-submit
[912.869595] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[912.975190] [032/131] (796s left) gem_mmap_offset (close-race)
[913.040686] Starting subtest: close-race
[933.152884] Subtest close-race: SUCCESS (20.110s)
[933.286972] [033/131] (776s left) kms_atomic_transition (plane-all-transition-nonblocking)
[933.390311] Starting subtest: plane-all-transition-nonblocking
[933.392605] Starting dynamic subtest: pipe-A-eDP-1
[935.883234] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.495s)
[936.204281] Starting dynamic subtest: pipe-B-eDP-1
[939.411606] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.217s)
[939.718854] Subtest plane-all-transition-nonblocking: SUCCESS (6.330s)
[940.563017] [034/131] (769s left) kms_atomic_transition (modeset-transition-fencing)
[940.668620] Starting subtest: modeset-transition-fencing
[940.670575] Starting dynamic subtest: 1x-outputs
[951.496130] Dynamic subtest 1x-outputs: SUCCESS (10.827s)
[951.498710] Subtest modeset-transition-fencing: SUCCESS (10.828s)
[952.377677] [035/131] (757s left) syncobj_timeline (wait-delayed-signal)
[952.441879] Starting subtest: wait-delayed-signal
[952.544229] Subtest wait-delayed-signal: SUCCESS (0.102s)
[952.648653] [036/131] (757s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[952.746174] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[952.750570] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[952.878553] [037/131] (756s left) kms_dp_link_training (uhbr-sst)
[952.974299] Starting subtest: uhbr-sst
[952.982587] Subtest uhbr-sst: SKIP (0.000s)
[953.069748] [038/131] (756s left) kms_vblank (ts-continuation-modeset-hang)
[953.174583] Starting subtest: ts-continuation-modeset-hang
[953.176805] Starting dynamic subtest: pipe-A-eDP-1
[979.187164] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.012s)
[979.202591] Starting dynamic subtest: pipe-D-eDP-1
[1004.148004] Dynamic subtest pipe-D-eDP-1: SUCCESS (24.955s)
[1004.150206] Subtest ts-continuation-modeset-hang: SUCCESS (50.971s)
[1004.993684] [039/131] (704s left) kms_setmode (clone-exclusive-crtc)
[1005.055400] Starting subtest: clone-exclusive-crtc
[1005.061630] Subtest clone-exclusive-crtc: SKIP (0.000s)
[1005.176137] [040/131] (704s left) syncobj_basic (bad-destroy)
[1005.233638] Starting subtest: bad-destroy
[1005.235844] Subtest bad-destroy: SUCCESS (0.000s)
[1005.361334] [041/131] (704s left) kms_plane_scaling (planes-downscale-factor-0-75)
[1005.459593] Starting subtest: planes-downscale-factor-0-75
[1005.461926] Starting dynamic subtest: pipe-A
[1005.480666] Dynamic subtest pipe-A: SKIP (0.016s)
[1005.497023] Starting dynamic subtest: pipe-B
[1005.511551] Dynamic subtest pipe-B: SKIP (0.030s)
[1005.522164] Starting dynamic subtest: pipe-C
[1005.539983] Dynamic subtest pipe-C: SKIP (0.029s)
[1005.549553] Starting dynamic subtest: pipe-D
[1005.570544] Dynamic subtest pipe-D: SKIP (0.029s)
[1005.574893] Subtest planes-downscale-factor-0-75: SKIP (0.107s)
[1005.693966] [042/131] (704s left) kms_lease (lease-uevent)
[1005.789474] Starting subtest: lease-uevent
[1006.802281] Subtest lease-uevent: SUCCESS (1.011s)
[1006.942565] [043/131] (703s left) gem_exec_whisper (basic-contexts-priority)
[1007.013632] Starting subtest: basic-contexts-priority
[1031.855258] Subtest basic-contexts-priority: SUCCESS (24.840s)
[1032.061060] [044/131] (677s left) kms_plane_scaling (plane-upscale-20x20-with-modifiers)
[1032.170313] Starting subtest: plane-upscale-20x20-with-modifiers
[1032.172641] Starting dynamic subtest: pipe-A
[1032.505708] Dynamic subtest pipe-A: SUCCESS (0.338s)
[1032.518415] Starting dynamic subtest: pipe-B
[1033.949654] Dynamic subtest pipe-B: SUCCESS (1.443s)
[1033.959682] Starting dynamic subtest: pipe-C
[1035.397364] Dynamic subtest pipe-C: SUCCESS (1.447s)
[1035.409505] Starting dynamic subtest: pipe-D
[1036.817434] Dynamic subtest pipe-D: SUCCESS (1.418s)
[1036.819707] Subtest plane-upscale-20x20-with-modifiers: SUCCESS (4.651s)
[1038.011463] [045/131] (672s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt)
[1038.106994] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt
[1042.638911] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.535s)
[1043.836574] [046/131] (666s left) kms_flip (dpms-off-confusion-interruptible)
[1043.931894] Starting subtest: dpms-off-confusion-interruptible
[1043.934047] Starting dynamic subtest: A-eDP1
[1052.599200] Dynamic subtest A-eDP1: SUCCESS (8.666s)
[1052.610178] Starting dynamic subtest: B-eDP1
[1061.248882] Dynamic subtest B-eDP1: SUCCESS (8.649s)
[1061.260280] Starting dynamic subtest: C-eDP1
[1069.873862] Dynamic subtest C-eDP1: SUCCESS (8.624s)
[1069.885237] Starting dynamic subtest: D-eDP1
[1078.495619] Dynamic subtest D-eDP1: SUCCESS (8.621s)
[1078.500863] Subtest dpms-off-confusion-interruptible: SUCCESS (34.568s)
[1079.683165] [047/131] (630s left) api_intel_allocator (reopen-fork)
[1079.748280] Starting subtest: reopen-fork
[1083.338451] Subtest reopen-fork: SUCCESS (3.589s)
[1083.444012] [048/131] (626s left) syncobj_timeline (single-wait-all-signaled)
[1083.496193] Starting subtest: single-wait-all-signaled
[1083.498573] Subtest single-wait-all-signaled: SUCCESS (0.000s)
[1083.629819] [049/131] (626s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite)
[1083.728816] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite
[1083.732766] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s)
[1083.863847] [050/131] (626s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt)
[1083.963653] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt
[1083.967643] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[1084.066288] [051/131] (626s left) gem_exec_balancer (bonded-pair)
[1084.134752] Starting subtest: bonded-pair
[1084.139334] Subtest bonded-pair: SKIP (0.000s)
[1084.481144] [052/131] (625s left) gem_ctx_shared (exec-shared-gtt)
[1084.543759] Starting subtest: exec-shared-gtt
[1084.546125] Starting dynamic subtest: rcs0
[1084.551307] Dynamic subtest rcs0: SUCCESS (0.007s)
[1084.562619] Starting dynamic subtest: bcs0
[1084.564684] Dynamic subtest bcs0: SUCCESS (0.006s)
[1084.574047] Starting dynamic subtest: vcs0
[1084.575894] Dynamic subtest vcs0: SUCCESS (0.007s)
[1084.585660] Starting dynamic subtest: vcs1
[1084.587899] Dynamic subtest vcs1: SUCCESS (0.006s)
[1084.598516] Starting dynamic subtest: vecs0
[1084.600586] Dynamic subtest vecs0: SUCCESS (0.005s)
[1084.610053] Starting dynamic subtest: ccs0
[1084.612341] Dynamic subtest ccs0: SUCCESS (0.005s)
[1084.614427] Subtest exec-shared-gtt: SUCCESS (0.040s)
[1084.796057] [053/131] (625s left) kms_flip (2x-modeset-vs-vblank-race)
[1084.895232] Starting subtest: 2x-modeset-vs-vblank-race
[1084.904134] Subtest 2x-modeset-vs-vblank-race: SKIP (0.010s)
[1085.012219] [054/131] (625s left) kms_color_pipeline (plane-lut1d-ctm3x4)
[1085.115318] Starting subtest: plane-lut1d-ctm3x4
[1085.128511] Starting dynamic subtest: pipe-A-eDP-1
[1085.761290] Dynamic subtest pipe-A-eDP-1: FAIL (0.317s)
[1086.533938] Starting dynamic subtest: pipe-B-eDP-1
[1087.365540] Dynamic subtest pipe-B-eDP-1: FAIL (0.313s)
[1087.963037] Starting dynamic subtest: pipe-C-eDP-1
[1088.768955] Dynamic subtest pipe-C-eDP-1: FAIL (0.234s)
[1089.297441] Starting dynamic subtest: pipe-D-eDP-1
[1090.123461] Dynamic subtest pipe-D-eDP-1: FAIL (0.246s)
[1090.125642] Subtest plane-lut1d-ctm3x4: FAIL (4.708s)
[1090.695350] [055/131] (619s left) kms_selftest (drm_dp_mst_helper)
[1090.735545] Starting subtest: drm_dp_mst_helper
[1090.805035] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_mode
[1090.967625] Dynamic subtest drm_test_dp_mst_calc_pbn_mode: SUCCESS (0.165s)
[1090.979101] Starting dynamic subtest: drm_test_dp_mst_calc_pbn_div
[1091.120604] Dynamic subtest drm_test_dp_mst_calc_pbn_div: SUCCESS (0.153s)
[1091.131340] Starting dynamic subtest: drm_test_dp_mst_sideband_msg_req_decode
[1091.273420] Dynamic subtest drm_test_dp_mst_sideband_msg_req_decode: SUCCESS (0.153s)
[1091.275299] Subtest drm_dp_mst_helper: SUCCESS (0.539s)
[1091.507843] [056/131] (619s left) kms_plane_cursor (overlay)
[1091.596880] Starting subtest: overlay
[1091.600917] Starting dynamic subtest: pipe-A-eDP-1-size-64
[1094.015136] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.418s)
[1094.075763] Starting dynamic subtest: pipe-A-eDP-1-size-128
[1096.593623] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.527s)
[1096.654603] Starting dynamic subtest: pipe-A-eDP-1-size-256
[1099.106286] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.459s)
[1099.457321] Starting dynamic subtest: pipe-B-eDP-1-size-64
[1102.636038] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.192s)
[1102.695809] Starting dynamic subtest: pipe-B-eDP-1-size-128
[1105.159200] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.471s)
[1105.220480] Starting dynamic subtest: pipe-B-eDP-1-size-256
[1107.727065] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.517s)
[1108.078140] Starting dynamic subtest: pipe-C-eDP-1-size-64
[1110.900875] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.832s)
[1110.939651] Starting dynamic subtest: pipe-C-eDP-1-size-128
[1113.011356] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.080s)
[1113.049617] Starting dynamic subtest: pipe-C-eDP-1-size-256
[1115.157345] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.113s)
[1115.484832] Starting dynamic subtest: pipe-D-eDP-1-size-64
[1118.269583] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.795s)
[1118.308847] Starting dynamic subtest: pipe-D-eDP-1-size-128
[1120.391773] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.090s)
[1120.430874] Starting dynamic subtest: pipe-D-eDP-1-size-256
[1122.481601] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.058s)
[1122.826098] Subtest overlay: SUCCESS (31.228s)
[1123.715997] [057/131] (586s left) gem_ctx_persistence (heartbeat-hang)
[1123.785418] Starting subtest: heartbeat-hang
[1123.790228] Subtest heartbeat-hang: SKIP (0.000s)
[1123.925020] [058/131] (586s left) kms_chamelium_hpd (dp-hpd-storm)
[1124.312204] Subtest dp-hpd-storm: SKIP (0.000s)
[1125.110089] [059/131] (585s left) gem_exec_schedule (preempt-self)
[1125.195751] Starting subtest: preempt-self
[1125.197949] Starting dynamic subtest: rcs0
[1125.208313] Dynamic subtest rcs0: SUCCESS (0.019s)
[1125.220206] Starting dynamic subtest: bcs0
[1125.227190] Dynamic subtest bcs0: SUCCESS (0.017s)
[1125.245170] Starting dynamic subtest: vcs0
[1125.247430] Dynamic subtest vcs0: SUCCESS (0.018s)
[1125.256744] Starting dynamic subtest: vcs1
[1125.262211] Dynamic subtest vcs1: SUCCESS (0.015s)
[1125.271175] Starting dynamic subtest: vecs0
[1125.277798] Dynamic subtest vecs0: SUCCESS (0.015s)
[1125.287000] Starting dynamic subtest: ccs0
[1125.294294] Dynamic subtest ccs0: SUCCESS (0.016s)
[1125.296411] Subtest preempt-self: SUCCESS (0.106s)
[1126.541979] [060/131] (584s left) gem_userptr_blits (create-destroy-unsync)
[1126.623818] Subtest create-destroy-unsync: SKIP (0.000s)
[1126.793438] [061/131] (583s left) kms_pm_rpm (modeset-non-lpsp-stress)
[1128.524262] Starting subtest: modeset-non-lpsp-stress
[1129.663891] Subtest modeset-non-lpsp-stress: SKIP (1.140s)
[1130.032375] [062/131] (580s left) kms_frontbuffer_tracking (fbcpsr-2p-rte)
[1130.142296] Starting subtest: fbcpsr-2p-rte
[1130.146560] Subtest fbcpsr-2p-rte: SKIP (0.000s)
[1130.280528] [063/131] (580s left) kms_big_fb (y-tiled-32bpp-rotate-0)
[1130.386744] Starting subtest: y-tiled-32bpp-rotate-0
[1130.391146] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s)
[1130.535697] [064/131] (580s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[1130.635702] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[1130.638057] Starting dynamic subtest: A-eDP1
[1139.570228] Dynamic subtest A-eDP1: SUCCESS (8.933s)
[1139.581502] Starting dynamic subtest: B-eDP1
[1148.504915] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[1148.514728] Starting dynamic subtest: C-eDP1
[1157.416359] Dynamic subtest C-eDP1: SUCCESS (8.909s)
[1157.426775] Starting dynamic subtest: D-eDP1
[1166.248187] Dynamic subtest D-eDP1: SUCCESS (8.831s)
[1166.251042] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.614s)
[1167.499311] [065/131] (543s left) kms_dsc (dsc-basic)
[1167.591438] Starting subtest: dsc-basic
[1167.604283] Subtest dsc-basic: SKIP (0.000s)
[1167.695937] [066/131] (543s left) gem_ctx_engines (independent)
[1167.760518] Starting subtest: independent
[1167.762810] Starting dynamic subtest: rcs0
[1167.919314] Dynamic subtest rcs0: SUCCESS (0.157s)
[1167.931588] Starting dynamic subtest: bcs0
[1168.053407] Dynamic subtest bcs0: SUCCESS (0.134s)
[1168.066021] Starting dynamic subtest: vcs0
[1168.161468] Dynamic subtest vcs0: SUCCESS (0.108s)
[1168.174342] Starting dynamic subtest: vcs1
[1168.248533] Dynamic subtest vcs1: SUCCESS (0.086s)
[1168.261473] Starting dynamic subtest: vecs0
[1168.336822] Dynamic subtest vecs0: SUCCESS (0.087s)
[1168.349824] Starting dynamic subtest: ccs0
[1168.451638] Dynamic subtest ccs0: SUCCESS (0.114s)
[1168.464115] Starting dynamic subtest: all-engines
[1168.919625] Dynamic subtest all-engines: SUCCESS (0.466s)
[1168.921631] Subtest independent: SUCCESS (1.159s)
[1169.582981] [067/131] (541s left) i915_drm_fdinfo (all-busy-idle-check-all)
[1169.622664] Starting subtest: all-busy-idle-check-all
[1169.627187] Subtest all-busy-idle-check-all: SKIP (0.003s)
[1169.714202] [068/131] (541s left) gen7_exec_parse (load-register-reg)
[1169.803763] Subtest load-register-reg: SKIP (0.000s)
[1169.892593] [069/131] (541s left) tools_test (sysfs_l3_parity)
[1169.939812] Starting subtest: sysfs_l3_parity
[1170.016818] Subtest sysfs_l3_parity: SKIP (0.087s)
[1170.096740] [070/131] (541s left) gem_blits (basic)
[1170.157296] Starting subtest: basic
[1172.144358] Subtest basic: SUCCESS (1.986s)
[1172.294311] [071/131] (538s left) kms_psr (psr2-sprite-render)
[1172.400964] Starting subtest: psr2-sprite-render
[1172.403081] Starting dynamic subtest: eDP-1
[1174.085086] Dynamic subtest eDP-1: SUCCESS (1.685s)
[1174.087313] Subtest psr2-sprite-render: SUCCESS (1.686s)
[1174.977134] [072/131] (536s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted)
[1175.034948] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[1175.037023] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[1175.172930] [073/131] (536s left) gem_exec_endless (dispatch)
[1175.242487] Starting subtest: dispatch
[1175.244794] Starting dynamic subtest: rcs0
[1175.249019] Dynamic subtest rcs0: SUCCESS (0.005s)
[1175.260085] Starting dynamic subtest: bcs0
[1175.264071] Dynamic subtest bcs0: SUCCESS (0.004s)
[1175.273848] Starting dynamic subtest: vcs0
[1175.278377] Dynamic subtest vcs0: SUCCESS (0.004s)
[1175.287062] Starting dynamic subtest: vcs1
[1175.290928] Dynamic subtest vcs1: SUCCESS (0.005s)
[1175.299674] Starting dynamic subtest: vecs0
[1175.303673] Dynamic subtest vecs0: SUCCESS (0.005s)
[1175.312592] Starting dynamic subtest: ccs0
[1175.316450] Dynamic subtest ccs0: SUCCESS (0.004s)
[1175.318220] Subtest dispatch: SUCCESS (0.031s)
[1176.439467] [074/131] (534s left) drm_read (fault-buffer)
[1176.596986] Starting subtest: fault-buffer
[1176.599280] Subtest fault-buffer: SUCCESS (0.001s)
[1176.754939] [075/131] (534s left) sw_sync (sync_expired_merge)
[1176.796881] Starting subtest: sync_expired_merge
[1177.870782] Subtest sync_expired_merge: SUCCESS (1.074s)
[1177.955056] [076/131] (533s left) perf (gen12-group-concurrent-oa-buffer-read)
[1178.063238] Starting subtest: gen12-group-concurrent-oa-buffer-read
[1188.109866] Subtest gen12-group-concurrent-oa-buffer-read: SUCCESS (10.045s)
[1188.166646] [077/131] (523s left) kms_async_flips (async-flip-with-page-flip-events-tiled)
[1188.251180] Starting subtest: async-flip-with-page-flip-events-tiled
[1188.625108] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs
[1191.423776] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.798s)
[1191.435628] Starting dynamic subtest: pipe-A-eDP-1-4
[1193.599337] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.174s)
[1193.616918] Starting dynamic subtest: pipe-A-eDP-1-4
[1195.609505] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.009s)
[1195.626831] Starting dynamic subtest: pipe-A-eDP-1-x
[1197.788416] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.177s)
[1198.155126] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs
[1200.951731] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.804s)
[1200.961797] Starting dynamic subtest: pipe-B-eDP-1-4
[1203.125759] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.173s)
[1203.135649] Starting dynamic subtest: pipe-B-eDP-1-4
[1205.136162] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.009s)
[1205.146458] Starting dynamic subtest: pipe-B-eDP-1-x
[1207.326195] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.189s)
[1207.706550] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs
[1210.474810] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.776s)
[1210.484887] Starting dynamic subtest: pipe-C-eDP-1-4
[1212.651106] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.174s)
[1212.661681] Starting dynamic subtest: pipe-C-eDP-1-4
[1214.660718] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s)
[1214.671168] Starting dynamic subtest: pipe-C-eDP-1-x
[1216.827844] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.166s)
[1217.193209] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs
[1219.999539] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.814s)
[1220.009952] Starting dynamic subtest: pipe-D-eDP-1-4
[1222.163328] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.163s)
[1222.173342] Starting dynamic subtest: pipe-D-eDP-1-4
[1224.173970] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.009s)
[1224.184617] Starting dynamic subtest: pipe-D-eDP-1-x
[1226.340976] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.166s)
[1226.343262] Subtest async-flip-with-page-flip-events-tiled: SUCCESS (38.091s)
[1227.521302] [078/131] (483s left) kms_atomic_interruptible (legacy-setmode)
[1227.605068] Starting subtest: legacy-setmode
[1227.607313] Starting dynamic subtest: pipe-A-eDP-1
[1234.473295] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.865s)
[1234.475587] Subtest legacy-setmode: SUCCESS (6.866s)
[1235.286364] [079/131] (476s left) kms_frontbuffer_tracking (fbc-tiling-y)
[1235.386551] Starting subtest: fbc-tiling-y
[1235.390583] Subtest fbc-tiling-y: SKIP (0.000s)
[1235.522073] [080/131] (476s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[1235.649431] Starting subtest: flip-vs-cursor-crc-legacy
[1236.287039] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.637s)
[1237.117259] [081/131] (474s left) kms_cursor_crc (cursor-sliding-32x32)
[1237.271488] Starting subtest: cursor-sliding-32x32
[1237.313498] Subtest cursor-sliding-32x32: SKIP (0.039s)
[1237.617095] [082/131] (474s left) kms_content_protection (legacy)
[1237.770004] Starting subtest: legacy
[1237.774702] Subtest legacy: SKIP (0.000s)
[1237.954566] [083/131] (473s left) gem_render_copy_redux (flink)
[1238.023214] Starting subtest: flink
[1238.696100] Subtest flink: SUCCESS (0.676s)
[1238.872221] [084/131] (472s left) perf_pmu (faulting-read)
[1238.907318] Starting subtest: faulting-read
[1238.909354] Starting dynamic subtest: wb
[1238.911222] Dynamic subtest wb: SUCCESS (0.001s)
[1238.927108] Starting dynamic subtest: wc
[1238.929284] Dynamic subtest wc: SUCCESS (0.000s)
[1238.940278] Starting dynamic subtest: uc
[1238.941834] Dynamic subtest uc: SUCCESS (0.000s)
[1238.943397] Subtest faulting-read: SUCCESS (0.003s)
[1239.054398] [085/131] (472s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-render)
[1239.142995] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-render
[1243.545270] Subtest fbc-1p-primscrn-pri-indfb-draw-render: SUCCESS (4.404s)
[1244.714883] [086/131] (467s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[1244.801384] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[1244.803637] Starting dynamic subtest: pipe-A-eDP-1
[1244.826138] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[1244.838653] Starting dynamic subtest: pipe-B-eDP-1
[1244.859758] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[1244.869405] Starting dynamic subtest: pipe-C-eDP-1
[1244.891343] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[1244.900643] Starting dynamic subtest: pipe-D-eDP-1
[1244.922352] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[1244.926640] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[1246.972842] [087/131] (464s left) api_intel_bb (render)
[1247.036727] Starting subtest: render
[1247.038674] Starting dynamic subtest: render-none-512
[1247.133593] Dynamic subtest render-none-512: SUCCESS (0.098s)
[1247.146288] Starting dynamic subtest: render-none-1024
[1247.566279] Dynamic subtest render-none-1024: SUCCESS (0.430s)
[1247.579102] Starting dynamic subtest: render-x-512
[1247.649567] Dynamic subtest render-x-512: SUCCESS (0.084s)
[1247.661924] Starting dynamic subtest: render-x-1024
[1247.983838] Dynamic subtest render-x-1024: SUCCESS (0.333s)
[1247.996464] Starting dynamic subtest: render-y-512
[1248.090743] Dynamic subtest render-y-512: SUCCESS (0.106s)
[1248.103078] Starting dynamic subtest: render-y-1024
[1248.425284] Dynamic subtest render-y-1024: SUCCESS (0.333s)
[1248.428031] Subtest render: SUCCESS (1.390s)
[1248.568709] [088/131] (463s left) gem_exec_schedule (preempt)
[1248.643149] Starting subtest: preempt
[1248.645419] Starting dynamic subtest: rcs0
[1248.657537] Dynamic subtest rcs0: SUCCESS (0.022s)
[1248.667489] Starting dynamic subtest: bcs0
[1248.679499] Dynamic subtest bcs0: SUCCESS (0.021s)
[1248.690396] Starting dynamic subtest: vcs0
[1248.697810] Dynamic subtest vcs0: SUCCESS (0.018s)
[1248.707677] Starting dynamic subtest: vcs1
[1248.716335] Dynamic subtest vcs1: SUCCESS (0.018s)
[1248.726210] Starting dynamic subtest: vecs0
[1248.734269] Dynamic subtest vecs0: SUCCESS (0.017s)
[1248.744257] Starting dynamic subtest: ccs0
[1248.753572] Dynamic subtest ccs0: SUCCESS (0.019s)
[1248.755772] Subtest preempt: SUCCESS (0.119s)
[1250.558826] [089/131] (461s left) gem_eio (reset-stress)
[1250.789976] Starting subtest: reset-stress
[1250.792513] Starting dynamic subtest: render
[1256.129927] Dynamic subtest render: SUCCESS (5.336s)
[1256.144942] Starting dynamic subtest: bsd1
[1273.944857] Dynamic subtest bsd1: SUCCESS (17.814s)
[1273.961342] Starting dynamic subtest: bsd2
[1291.921291] Dynamic subtest bsd2: SUCCESS (17.975s)
[1291.937479] Starting dynamic subtest: blt
[1291.941664] Dynamic subtest blt: SKIP (0.000s)
[1291.950680] Starting dynamic subtest: vebox
[1309.930658] Dynamic subtest vebox: SUCCESS (18.008s)
[1309.933099] Subtest reset-stress: SUCCESS (59.139s)
[1311.483113] [090/131] (400s left) gem_pxp (reject-modify-context-protection-off-3)
[1311.596905] Starting subtest: reject-modify-context-protection-off-3
[1311.599315] Subtest reject-modify-context-protection-off-3: SUCCESS (0.001s)
[1311.728753] [091/131] (400s left) syncobj_timeline (etime-multi-wait-all-available-unsubmitted)
[1311.789372] Starting subtest: etime-multi-wait-all-available-unsubmitted
[1311.894314] Subtest etime-multi-wait-all-available-unsubmitted: SUCCESS (0.104s)
[1311.995621] [092/131] (400s left) gem_exec_parallel (engines)
[1312.065588] Starting subtest: engines
[1312.068087] Starting dynamic subtest: basic
[1315.386775] Dynamic subtest basic: SUCCESS (3.319s)
[1315.398959] Starting dynamic subtest: contexts
[1319.881059] Dynamic subtest contexts: SUCCESS (4.492s)
[1319.893731] Starting dynamic subtest: fds
[1323.692834] Dynamic subtest fds: SUCCESS (3.809s)
[1323.705887] Starting dynamic subtest: userptr
[1325.459733] Dynamic subtest userptr: SUCCESS (1.765s)
[1325.462433] Subtest engines: SUCCESS (13.394s)
[1325.672326] [093/131] (386s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc)
[1325.782417] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc
[1329.341799] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (3.564s)
[1330.567210] [094/131] (381s left) kms_psr (fbc-psr-cursor-plane-move)
[1330.667540] Starting subtest: fbc-psr-cursor-plane-move
[1330.669463] Starting dynamic subtest: eDP-1
[1330.673356] Dynamic subtest eDP-1: SKIP (0.000s)
[1330.677280] Subtest fbc-psr-cursor-plane-move: SKIP (0.001s)
[1330.767644] [095/131] (381s left) kms_chamelium_frames (hdmi-crc-nonplanar-formats)
[1331.146068] Subtest hdmi-crc-nonplanar-formats: SKIP (0.000s)
[1331.932796] [096/131] (380s left) gem_exec_params (invalid-ring2)
[1332.000943] Starting subtest: invalid-ring2
[1332.002908] Subtest invalid-ring2: SUCCESS (0.000s)
[1332.135979] [097/131] (380s left) kms_flip (basic-flip-vs-dpms)
[1332.239305] Starting subtest: basic-flip-vs-dpms
[1332.241418] Starting dynamic subtest: A-eDP1
[1334.855091] Dynamic subtest A-eDP1: SUCCESS (2.616s)
[1334.865347] Starting dynamic subtest: B-eDP1
[1337.010894] Dynamic subtest B-eDP1: SUCCESS (2.154s)
[1337.021271] Starting dynamic subtest: C-eDP1
[1339.085839] Dynamic subtest C-eDP1: SUCCESS (2.076s)
[1339.097259] Starting dynamic subtest: D-eDP1
[1341.148783] Dynamic subtest D-eDP1: SUCCESS (2.060s)
[1341.150891] Subtest basic-flip-vs-dpms: SUCCESS (8.913s)
[1341.972899] [098/131] (370s left) kms_pipe_b_c_ivb (pipe-b-double-modeset-then-modeset-pipe-c)
[1342.037096] Subtest pipe-B-double-modeset-then-modeset-pipe-C: SKIP (0.000s)
[1342.100933] [099/131] (370s left) vgem_basic (sysfs)
[1342.143605] Starting subtest: sysfs
[1342.146113] Subtest sysfs: SUCCESS (0.000s)
[1342.219505] [100/131] (370s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[1342.325378] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[1342.982591] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.659s)
[1343.224074] [101/131] (369s left) i915_selftest (perf)
[1348.101845] Starting subtest: perf
[1348.103977] Starting dynamic subtest: engine_cs
[1352.574683] Dynamic subtest engine_cs: SUCCESS (4.472s)
[1352.584674] Starting dynamic subtest: request
[1360.017501] Dynamic subtest request: SUCCESS (7.441s)
[1360.026677] Starting dynamic subtest: migrate
[1364.523624] Dynamic subtest migrate: SUCCESS (4.503s)
[1364.533433] Starting dynamic subtest: region
[1370.507851] Dynamic subtest region: SUCCESS (5.981s)
[1370.510394] Subtest perf: SUCCESS (22.406s)
[1370.538279] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[1370.539005] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true
[1370.542310] [102/131] (341s left) kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)
[1372.117206] Starting subtest: crc-primary-basic-y-tiled-gen12-mc-ccs
[1372.119389] Starting dynamic subtest: pipe-A-eDP-1
[1372.142044] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[1372.157699] Starting dynamic subtest: pipe-B-eDP-1
[1372.179943] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[1372.190439] Starting dynamic subtest: pipe-C-eDP-1
[1372.211973] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[1372.220093] Starting dynamic subtest: pipe-D-eDP-1
[1372.241814] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[1372.245869] Subtest crc-primary-basic-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[1374.328805] [FACT kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[1374.330016] [FACT kms_ccs (crc-primary-basic-y-tiled-gen12-mc-ccs)] new: kernel.kmod_is_loaded.i915: true
[1374.333938] [103/131] (338s left) syncobj_timeline (multi-wait-available-submitted-signaled)
[1374.408251] Starting subtest: multi-wait-available-submitted-signaled
[1374.410589] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.000s)
[1374.545192] [104/131] (338s left) gem_lmem_swapping (verify)
[1374.590282] Subtest verify: SKIP (0.000s)
[1374.625212] [105/131] (337s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area)
[1379.895037] Starting subtest: pr-primary-plane-update-sf-dmg-area
[1379.899605] Subtest pr-primary-plane-update-sf-dmg-area: SKIP (0.002s)
[1380.773458] [106/131] (331s left) gem_userptr_blits (sync-unmap-cycles)
[1380.844024] Starting subtest: sync-unmap-cycles
[1386.215612] Subtest sync-unmap-cycles: SUCCESS (5.371s)
[1386.394184] [107/131] (326s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-blt)
[1386.508608] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-blt
[1386.512019] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[1386.613701] [108/131] (326s left) gem_mmap_gtt (basic)
[1386.653815] Subtest basic: SKIP (0.000s)
[1386.722115] [109/131] (326s left) i915_pm_rpm (debugfs-read)
[1388.538284] Starting subtest: debugfs-read
[1389.701753] Subtest debugfs-read: SUCCESS (1.164s)
[1390.082633] [110/131] (322s left) gem_userptr_blits (map-fixed-invalidate-overlap-busy)
[1390.153200] Starting subtest: map-fixed-invalidate-overlap-busy
[1390.162823] Subtest map-fixed-invalidate-overlap-busy: SKIP (0.000s)
[1390.303666] [111/131] (322s left) kms_properties (connector-properties-legacy)
[1390.403013] Starting subtest: connector-properties-legacy
[1390.404848] Starting dynamic subtest: pipe-A-eDP-1
[1398.366521] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.962s)
[1398.376534] Starting dynamic subtest: pipe-None-DP-1
[1398.381098] Dynamic subtest pipe-None-DP-1: SUCCESS (0.001s)
[1398.389590] Starting dynamic subtest: pipe-None-HDMI-A-1
[1398.393952] Dynamic subtest pipe-None-HDMI-A-1: SUCCESS (0.001s)
[1398.401769] Starting dynamic subtest: pipe-None-DP-2
[1398.405815] Dynamic subtest pipe-None-DP-2: SUCCESS (0.001s)
[1398.413700] Starting dynamic subtest: pipe-None-HDMI-A-2
[1398.417742] Dynamic subtest pipe-None-HDMI-A-2: SUCCESS (0.001s)
[1398.425435] Starting dynamic subtest: pipe-None-DP-3
[1398.429452] Dynamic subtest pipe-None-DP-3: SUCCESS (0.001s)
[1398.439608] Starting dynamic subtest: pipe-None-DP-4
[1398.444855] Dynamic subtest pipe-None-DP-4: SUCCESS (0.001s)
[1398.447298] Subtest connector-properties-legacy: SUCCESS (7.973s)
[1399.254545] [112/131] (313s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render)
[1399.347628] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render
[1399.351451] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s)
[1399.484608] [113/131] (313s left) syncobj_wait (single-wait-signaled)
[1399.536411] Starting subtest: single-wait-signaled
[1399.538597] Subtest single-wait-signaled: SUCCESS (0.000s)
[1399.685589] [114/131] (313s left) kms_prop_blob (invalid-get-prop)
[1399.736920] Starting subtest: invalid-get-prop
[1399.739068] Subtest invalid-get-prop: SUCCESS (0.000s)
[1399.879272] [115/131] (313s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-64bpp-ytile-upscaling)
[1399.978318] Starting subtest: flip-32bpp-ytile-to-64bpp-ytile-upscaling
[1399.980466] Starting dynamic subtest: pipe-A-default-mode
[1400.272266] Dynamic subtest pipe-A-default-mode: SKIP (0.289s)
[1400.277041] Subtest flip-32bpp-ytile-to-64bpp-ytile-upscaling: SKIP (0.292s)
[1401.090648] [116/131] (311s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render)
[1401.192574] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render
[1407.907453] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.716s)
[1408.043579] [117/131] (305s left) kms_ccs (bad-rotation-90-4-tiled-mtl-rc-ccs-cc)
[1408.136375] Starting subtest: bad-rotation-90-4-tiled-mtl-rc-ccs-cc
[1408.138609] Starting dynamic subtest: pipe-A-eDP-1
[1408.287530] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.140s)
[1408.298910] Starting dynamic subtest: pipe-B-eDP-1
[1408.318361] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.009s)
[1408.333977] Starting dynamic subtest: pipe-C-eDP-1
[1408.352327] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.010s)
[1408.360215] Starting dynamic subtest: pipe-D-eDP-1
[1408.378372] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s)
[1408.380138] Subtest bad-rotation-90-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.173s)
[1410.582304] [118/131] (302s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled)
[1410.651611] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled
[1410.654040] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s)
[1410.788286] [119/131] (302s left) kms_cursor_crc (cursor-onscreen-32x10)
[1410.955856] Starting subtest: cursor-onscreen-32x10
[1411.003102] Subtest cursor-onscreen-32x10: SKIP (0.043s)
[1411.309874] [120/131] (301s left) kms_psr (fbc-pr-basic)
[1411.410621] Starting subtest: fbc-pr-basic
[1411.414956] Subtest fbc-pr-basic: SKIP (0.000s)
[1411.502158] [121/131] (301s left) kms_frontbuffer_tracking (fbc-1p-pri-indfb-multidraw)
[1411.605401] Starting subtest: fbc-1p-pri-indfb-multidraw
[1424.486647] Subtest fbc-1p-pri-indfb-multidraw: SUCCESS (12.882s)
[1425.921138] [122/131] (287s left) kms_big_fb (x-tiled-addfb)
[1426.030330] Starting subtest: x-tiled-addfb
[1426.032731] Subtest x-tiled-addfb: SUCCESS (0.000s)
[1426.166362] [123/131] (287s left) kms_cursor_legacy (cursora-vs-flipa-toggle)
[1426.283203] Starting subtest: cursorA-vs-flipA-toggle
[1437.413621] Subtest cursorA-vs-flipA-toggle: SUCCESS (11.127s)
[1438.245315] [124/131] (275s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted)
[1438.317590] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted
[1438.422503] Subtest etime-multi-wait-all-for-submit-unsubmitted: SUCCESS (0.105s)
[1438.532630] [125/131] (274s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-render)
[1438.631019] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-render
[1445.819595] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.190s)
[1445.989403] [126/131] (267s left) core_setmaster_vs_auth
[1446.187952] [127/131] (267s left) kms_flip (flip-vs-dpms-on-nop)
[1446.280808] Starting subtest: flip-vs-dpms-on-nop
[1446.283097] Starting dynamic subtest: A-eDP1
[1448.122437] Dynamic subtest A-eDP1: SUCCESS (1.843s)
[1448.132544] Starting dynamic subtest: B-eDP1
[1449.948043] Dynamic subtest B-eDP1: SUCCESS (1.824s)
[1449.959431] Starting dynamic subtest: C-eDP1
[1451.783610] Dynamic subtest C-eDP1: SUCCESS (1.834s)
[1451.800551] Starting dynamic subtest: D-eDP1
[1453.602708] Dynamic subtest D-eDP1: SUCCESS (1.817s)
[1453.605306] Subtest flip-vs-dpms-on-nop: SUCCESS (7.328s)
[1454.839084] [128/131] (258s left) perf_pmu (multi-client)
[1454.887431] Starting subtest: multi-client
[1454.889754] Starting dynamic subtest: rcs0
[1455.947613] Dynamic subtest rcs0: SUCCESS (1.061s)
[1455.959129] Starting dynamic subtest: bcs0
[1456.999506] Dynamic subtest bcs0: SUCCESS (1.048s)
[1457.009595] Starting dynamic subtest: vcs0
[1458.051078] Dynamic subtest vcs0: SUCCESS (1.047s)
[1458.062322] Starting dynamic subtest: vcs1
[1459.441567] Dynamic subtest vcs1: SUCCESS (1.388s)
[1459.451868] Starting dynamic subtest: vecs0
[1461.427762] Dynamic subtest vecs0: SUCCESS (1.982s)
[1461.439251] Starting dynamic subtest: ccs0
[1463.411735] Dynamic subtest ccs0: SUCCESS (1.982s)
[1463.414354] Subtest multi-client: SUCCESS (8.527s)
[1463.557832] [129/131] (250s left) kms_chamelium_color (ctm-0-50)
[1463.662292] Subtest ctm-0-50: SKIP (0.000s)
[1463.709831] [130/131] (249s left) syncobj_wait (wait-for-submit-delayed-submit)
[1463.768045] Starting subtest: wait-for-submit-delayed-submit
[1463.870071] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s)
[1463.973414] [131/131] (249s left) syncobj_basic (bad-fd-to-handle)
[1464.025737] Starting subtest: bad-fd-to-handle
[1464.027737] Subtest bad-fd-to-handle: SUCCESS (0.000s)
[1464.130787] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: vgem_basic
results: parsing output: 3/ for test: gem_mmap_offset
results: parsing output: 4/ for test: kms_psr
results: parsing output: 5/ for test: gem_exec_reloc
results: parsing output: 6/ for test: kms_psr2_sf
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: kms_plane_multiple
results: parsing output: 12/ for test: gem_ctx_isolation
results: parsing output: 13/ for test: gem_exec_reloc
results: parsing output: 14/ for test: kms_fence_pin_leak
results: parsing output: 15/ for test: gem_render_copy
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_softpin
results: parsing output: 19/ for test: gem_exec_fence
results: parsing output: 20/ for test: kms_big_fb
results: parsing output: 21/ for test: syncobj_wait
results: parsing output: 22/ for test: kms_cursor_legacy
results: parsing output: 23/ for test: drm_mm
results: parsing output: 24/ for test: kms_joiner
results: parsing output: 25/ for test: gem_userptr_blits
results: parsing output: 26/ for test: gem_lmem_swapping
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_spin_batch
results: parsing output: 29/ for test: i915_drm_fdinfo
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: gem_mmap_offset
results: parsing output: 32/ for test: kms_atomic_transition
results: parsing output: 33/ for test: kms_atomic_transition
results: parsing output: 34/ for test: syncobj_timeline
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: kms_dp_link_training
results: parsing output: 37/ for test: kms_vblank
results: parsing output: 38/ for test: kms_setmode
results: parsing output: 39/ for test: syncobj_basic
results: parsing output: 40/ for test: kms_plane_scaling
results: parsing output: 41/ for test: kms_lease
results: parsing output: 42/ for test: gem_exec_whisper
results: parsing output: 43/ for test: kms_plane_scaling
results: parsing output: 44/ for test: kms_frontbuffer_tracking
results: parsing output: 45/ for test: kms_flip
results: parsing output: 46/ for test: api_intel_allocator
results: parsing output: 47/ for test: syncobj_timeline
results: parsing output: 48/ for test: kms_frontbuffer_tracking
results: parsing output: 49/ for test: kms_frontbuffer_tracking
results: parsing output: 50/ for test: gem_exec_balancer
results: parsing output: 51/ for test: gem_ctx_shared
results: parsing output: 52/ for test: kms_flip
results: parsing output: 53/ for test: kms_color_pipeline
results: parsing output: 54/ for test: kms_selftest
results: parsing output: 55/ for test: kms_plane_cursor
results: parsing output: 56/ for test: gem_ctx_persistence
results: parsing output: 57/ for test: kms_chamelium_hpd
results: parsing output: 58/ for test: gem_exec_schedule
results: parsing output: 59/ for test: gem_userptr_blits
results: parsing output: 60/ for test: kms_pm_rpm
results: parsing output: 61/ for test: kms_frontbuffer_tracking
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: kms_flip
results: parsing output: 64/ for test: kms_dsc
results: parsing output: 65/ for test: gem_ctx_engines
results: parsing output: 66/ for test: i915_drm_fdinfo
results: parsing output: 67/ for test: gen7_exec_parse
results: parsing output: 68/ for test: tools_test
results: parsing output: 69/ for test: gem_blits
results: parsing output: 70/ for test: kms_psr
results: parsing output: 71/ for test: syncobj_wait
results: parsing output: 72/ for test: gem_exec_endless
results: parsing output: 73/ for test: drm_read
results: parsing output: 74/ for test: sw_sync
results: parsing output: 75/ for test: perf
results: parsing output: 76/ for test: kms_async_flips
results: parsing output: 77/ for test: kms_atomic_interruptible
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_cursor_legacy
results: parsing output: 80/ for test: kms_cursor_crc
results: parsing output: 81/ for test: kms_content_protection
results: parsing output: 82/ for test: gem_render_copy_redux
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_ccs
results: parsing output: 86/ for test: api_intel_bb
results: parsing output: 87/ for test: gem_exec_schedule
results: parsing output: 88/ for test: gem_eio
results: parsing output: 89/ for test: gem_pxp
results: parsing output: 90/ for test: syncobj_timeline
results: parsing output: 91/ for test: gem_exec_parallel
results: parsing output: 92/ for test: kms_frontbuffer_tracking
results: parsing output: 93/ for test: kms_psr
results: parsing output: 94/ for test: kms_chamelium_frames
results: parsing output: 95/ for test: gem_exec_params
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_pipe_b_c_ivb
results: parsing output: 98/ for test: vgem_basic
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: i915_selftest
results: parsing output: 101/ for test: kms_ccs
results: parsing output: 102/ for test: syncobj_timeline
results: parsing output: 103/ for test: gem_lmem_swapping
results: parsing output: 104/ for test: kms_psr2_sf
results: parsing output: 105/ for test: gem_userptr_blits
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_mmap_gtt
results: parsing output: 108/ for test: i915_pm_rpm
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: kms_properties
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_wait
results: parsing output: 113/ for test: kms_prop_blob
results: parsing output: 114/ for test: kms_flip_scaled_crc
results: parsing output: 115/ for test: kms_frontbuffer_tracking
results: parsing output: 116/ for test: kms_ccs
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_cursor_crc
results: parsing output: 119/ for test: kms_psr
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: kms_cursor_legacy
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: core_setmaster_vs_auth
results: parsing output: 126/ for test: kms_flip
results: parsing output: 127/ for test: perf_pmu
results: parsing output: 128/ for test: kms_chamelium_color
results: parsing output: 129/ for test: syncobj_wait
results: parsing output: 130/ for test: syncobj_basic
Done.