[55.691832] Initializing watchdogs
[55.691878]   /dev/watchdog0
[55.704618] [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]
[55.708396] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.710374] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.713573] [001/130] (960s left) gem_exec_schedule (semaphore-user)
[55.848442] Starting subtest: semaphore-user
[55.911037] Subtest semaphore-user: SUCCESS (0.066s)
[56.971974] [002/130] (959s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[61.937058] Starting subtest: fbc-psr2-primary-plane-update-sf-dmg-area
[61.940037] Starting dynamic subtest: pipe-A-eDP-1
[62.723697] Dynamic subtest pipe-A-eDP-1: SKIP (0.789s)
[62.731109] Starting dynamic subtest: pipe-B-eDP-1
[63.836304] Dynamic subtest pipe-B-eDP-1: SKIP (1.121s)
[63.840661] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (1.913s)
[64.995601] [003/130] (951s left) kms_plane (plane-panning-top-left)
[65.092036] Starting subtest: plane-panning-top-left
[65.094447] Starting dynamic subtest: pipe-A
[66.722802] Dynamic subtest pipe-A: SUCCESS (1.638s)
[66.729656] Starting dynamic subtest: pipe-B
[68.976038] Dynamic subtest pipe-B: SUCCESS (2.259s)
[68.978437] Subtest plane-panning-top-left: SUCCESS (3.899s)
[69.767751] [004/130] (946s left) kms_legacy_colorkey (invalid-plane)
[69.861061] Starting subtest: invalid-plane
[69.863480] Starting dynamic subtest: zero-id
[69.865436] Dynamic subtest zero-id: SUCCESS (0.000s)
[69.871645] Starting dynamic subtest: outrange-id
[69.873792] Dynamic subtest outrange-id: SUCCESS (0.000s)
[69.876186] Subtest invalid-plane: SUCCESS (0.000s)
[69.924704] [005/130] (946s left) gem_mmap_gtt (basic-short)
[69.986167] Subtest basic-short: SKIP (0.000s)
[70.037241] [006/130] (946s left) syncobj_timeline (wait-all-for-submit-snapshot)
[70.095128] Starting subtest: wait-all-for-submit-snapshot
[70.176534] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[70.241322] [007/130] (946s left) prime_vgem (basic-fence-read)
[70.354502] Starting subtest: basic-fence-read
[70.362263] Subtest basic-fence-read: SKIP (0.005s)
[70.476057] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[70.479114] [008/130] (945s left) gem_exec_params (no-vebox)
[70.540907] Starting subtest: no-vebox
[70.543126] Subtest no-vebox: SUCCESS (0.002s)
[72.081570] [009/130] (944s left) perf (low-oa-exponent-permissions)
[72.185671] Starting subtest: low-oa-exponent-permissions
[72.231119] Subtest low-oa-exponent-permissions: SUCCESS (0.046s)
[72.271573] [010/130] (944s left) gem_exercise_blt (fast-copy)
[72.337767] Starting subtest: fast-copy
[72.339768] Starting dynamic subtest: linear-smem-smem
[72.361327] Dynamic subtest linear-smem-smem: SUCCESS (0.024s)
[72.370725] Starting dynamic subtest: xmajor-smem-smem
[72.380397] Dynamic subtest xmajor-smem-smem: SUCCESS (0.019s)
[72.389748] Starting dynamic subtest: tile4-smem-smem
[72.398280] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[72.404764] Starting dynamic subtest: tile64-smem-smem
[72.419088] Dynamic subtest tile64-smem-smem: SUCCESS (0.021s)
[72.421384] Subtest fast-copy: SUCCESS (0.082s)
[72.550258] [011/130] (943s left) gem_create (busy-create)
[72.617473] Starting subtest: busy-create
[72.619932] Starting dynamic subtest: smem0
[105.922083] Dynamic subtest smem0: SUCCESS (33.314s)
[105.924933] Subtest busy-create: SUCCESS (33.314s)
[106.106920] [012/130] (910s left) api_intel_bb (intel-bb-blit-x)
[106.162847] Starting subtest: intel-bb-blit-x
[109.633229] Subtest intel-bb-blit-x: SUCCESS (3.470s)
[109.759939] [013/130] (906s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[109.875273] Starting subtest: 4-tiled-32bpp-rotate-270
[109.893828] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.018s)
[110.025188] [014/130] (906s left) gem_exec_flush (basic-batch-kernel-default-wb)
[110.092729] Starting subtest: basic-batch-kernel-default-wb
[116.916140] Subtest basic-batch-kernel-default-wb: SUCCESS (6.824s)
[117.099558] [015/130] (899s left) perf_pmu (busy-no-semaphores)
[117.138687] Starting subtest: busy-no-semaphores
[117.141215] Starting dynamic subtest: rcs0
[117.722077] Dynamic subtest rcs0: SUCCESS (0.582s)
[117.732276] Starting dynamic subtest: bcs0
[118.272527] Dynamic subtest bcs0: SUCCESS (0.550s)
[118.283243] Starting dynamic subtest: vcs0
[118.821779] Dynamic subtest vcs0: SUCCESS (0.549s)
[118.831380] Starting dynamic subtest: vcs1
[120.432438] Dynamic subtest vcs1: SUCCESS (1.610s)
[120.443069] Starting dynamic subtest: vecs0
[122.415079] Dynamic subtest vecs0: SUCCESS (1.982s)
[122.424074] Starting dynamic subtest: ccs0
[124.462194] Dynamic subtest ccs0: SUCCESS (2.047s)
[124.465762] Subtest busy-no-semaphores: SUCCESS (7.322s)
[124.575189] [016/130] (891s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[124.629110] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[124.735424] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.105s)
[124.805159] [017/130] (891s left) kms_pm_rpm (modeset-lpsp)
[127.089579] Starting subtest: modeset-lpsp
[128.540734] Subtest modeset-lpsp: SUCCESS (1.451s)
[128.618871] [018/130] (887s left) kms_flip (2x-flip-vs-dpms)
[128.716723] Starting subtest: 2x-flip-vs-dpms
[128.728404] Subtest 2x-flip-vs-dpms: SKIP (0.011s)
[128.799290] [019/130] (887s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[128.899695] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[128.904246] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[129.008308] [020/130] (887s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[129.105215] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[129.107873] Starting dynamic subtest: pipe-A-default-mode
[130.238418] Dynamic subtest pipe-A-default-mode: SKIP (1.129s)
[130.243123] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SKIP (1.130s)
[130.394404] [021/130] (886s left) kms_content_protection (dp-mst-lic-type-0)
[130.554802] Starting subtest: dp-mst-lic-type-0
[130.559347] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[130.688212] [022/130] (886s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[130.790270] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[130.795074] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[131.939874] [023/130] (884s left) kms_getfb (getfb-handle-zero)
[131.998101] Starting subtest: getfb-handle-zero
[132.000623] Subtest getfb-handle-zero: SUCCESS (0.000s)
[132.088226] [024/130] (884s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[132.147796] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[132.152157] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SKIP (0.000s)
[132.325869] [025/130] (884s left) gem_ctx_create (basic-files)
[132.380082] Starting subtest: basic-files
[134.394335] Subtest basic-files: SUCCESS (2.014s)
[135.956368] [026/130] (880s left) gem_exec_create (forked)
[136.026154] Starting subtest: forked
[136.028668] Starting dynamic subtest: smem
[157.867244] Dynamic subtest smem: SUCCESS (21.838s)
[157.869952] Subtest forked: SUCCESS (21.838s)
[158.049506] [027/130] (858s left) i915_hangman (detector)
[158.111416] Starting subtest: detector
[158.113808] Starting dynamic subtest: rcs0
[168.904912] Dynamic subtest rcs0: SUCCESS (10.791s)
[168.915743] Starting dynamic subtest: bcs0
[180.873439] Dynamic subtest bcs0: SUCCESS (11.967s)
[180.884700] Starting dynamic subtest: vcs0
[192.841097] Dynamic subtest vcs0: SUCCESS (11.966s)
[192.852382] Starting dynamic subtest: vcs1
[203.913076] Dynamic subtest vcs1: SUCCESS (11.071s)
[203.922770] Starting dynamic subtest: vecs0
[215.817882] Dynamic subtest vecs0: SUCCESS (11.904s)
[215.828600] Starting dynamic subtest: ccs0
[225.932172] Dynamic subtest ccs0: SUCCESS (10.113s)
[225.935236] Subtest detector: SUCCESS (67.816s)
[226.003319] [028/130] (790s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[226.110872] Starting subtest: extended-modeset-hang-newfb-with-reset
[226.113120] Starting dynamic subtest: pipe-A
[239.785767] Dynamic subtest pipe-A: SUCCESS (13.671s)
[239.795504] Starting dynamic subtest: pipe-D
[254.618134] Dynamic subtest pipe-D: SUCCESS (14.832s)
[254.620563] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (28.506s)
[255.414616] [029/130] (761s left) gem_ctx_persistence (hang)
[255.474500] Starting subtest: hang
[255.479407] Subtest hang: SKIP (0.000s)
[255.575915] [030/130] (761s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[255.685053] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[255.689162] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[255.778251] [031/130] (761s left) kms_big_fb (linear-16bpp-rotate-180)
[255.875167] Starting subtest: linear-16bpp-rotate-180
[257.296288] Subtest linear-16bpp-rotate-180: SUCCESS (1.423s)
[257.432038] [032/130] (759s left) perf_pmu (idle-no-semaphores)
[257.470433] Starting subtest: idle-no-semaphores
[257.472693] Starting dynamic subtest: rcs0
[258.040685] Dynamic subtest rcs0: SUCCESS (0.569s)
[258.051538] Starting dynamic subtest: bcs0
[258.565440] Dynamic subtest bcs0: SUCCESS (0.523s)
[258.576911] Starting dynamic subtest: vcs0
[259.089106] Dynamic subtest vcs0: SUCCESS (0.523s)
[259.099909] Starting dynamic subtest: vcs1
[259.606738] Dynamic subtest vcs1: SUCCESS (0.516s)
[259.617174] Starting dynamic subtest: vecs0
[260.120506] Dynamic subtest vecs0: SUCCESS (0.513s)
[260.131898] Starting dynamic subtest: ccs0
[260.634588] Dynamic subtest ccs0: SUCCESS (0.513s)
[260.637712] Subtest idle-no-semaphores: SUCCESS (3.163s)
[260.743230] [033/130] (756s left) perf (disabled-read-error)
[260.823863] Starting subtest: disabled-read-error
[260.851572] Subtest disabled-read-error: SUCCESS (0.027s)
[260.884777] [034/130] (756s left) gem_mmap_gtt (basic-small-copy)
[260.932259] Subtest basic-small-copy: SKIP (0.000s)
[260.986966] [035/130] (756s left) kms_writeback (writeback-invalid-parameters)
[261.088082] Subtest writeback-invalid-parameters: SKIP (0.000s)
[261.125843] [036/130] (756s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[261.188061] Starting subtest: multi-wait-for-submit-available-submitted
[261.190424] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.000s)
[261.290613] [037/130] (755s left) gem_media_vme
[261.420965] [038/130] (755s left) perf (mi-rpc)
[261.503048] Starting subtest: mi-rpc
[261.507858] Subtest mi-rpc: SKIP (0.000s)
[261.541290] [039/130] (755s left) kms_big_fb (linear-32bpp-rotate-90)
[261.650951] Starting subtest: linear-32bpp-rotate-90
[261.673151] Subtest linear-32bpp-rotate-90: SKIP (0.022s)
[261.782664] [040/130] (755s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[261.879478] Starting subtest: yf-tiled-32bpp-rotate-90
[261.883041] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[261.979424] [041/130] (755s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[262.068624] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[262.070696] Starting dynamic subtest: pipe-A-eDP-1
[262.089648] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[262.099597] Starting dynamic subtest: pipe-B-eDP-1
[262.117484] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[262.124946] Starting dynamic subtest: pipe-C-eDP-1
[262.142708] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[262.149700] Starting dynamic subtest: pipe-D-eDP-1
[262.168025] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[262.171438] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SKIP (0.004s)
[264.260581] [042/130] (753s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[264.362478] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[269.300651] Subtest fbcpsr-rgb101010-draw-pwrite: SUCCESS (4.940s)
[269.428304] [043/130] (748s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[269.548980] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[270.773168] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (1.224s)
[270.920727] [044/130] (746s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[271.024760] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[271.027091] Starting dynamic subtest: pipe-A-eDP-1
[271.076963] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[271.086118] Starting dynamic subtest: pipe-B-eDP-1
[271.133696] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[271.141361] Starting dynamic subtest: pipe-C-eDP-1
[271.188444] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[271.196366] Starting dynamic subtest: pipe-D-eDP-1
[271.242891] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[271.246565] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.007s)
[273.162330] [045/130] (744s left) syncobj_eventfd (binary-wait)
[273.218027] Starting subtest: binary-wait
[273.226494] Subtest binary-wait: SUCCESS (0.010s)
[273.305443] [046/130] (744s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite)
[273.408175] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite
[278.388517] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SUCCESS (4.983s)
[278.521482] [047/130] (739s left) drm_fdinfo (virtual-busy)
[278.561725] Starting subtest: virtual-busy
[278.566505] Subtest virtual-busy: SKIP (0.000s)
[278.617572] [048/130] (739s left) kms_psr (psr2-sprite-mmap-cpu)
[278.712114] Starting subtest: psr2-sprite-mmap-cpu
[278.714339] Starting dynamic subtest: eDP-1
[280.433487] Dynamic subtest eDP-1: SUCCESS (1.720s)
[280.435779] Subtest psr2-sprite-mmap-cpu: SUCCESS (1.721s)
[281.297746] [049/130] (736s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[286.354617] Starting subtest: pr-overlay-primary-update-sf-dmg-area
[286.359402] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[287.202888] [050/130] (730s left) sysfs_preempt_timeout (timeout)
[287.268585] Starting subtest: timeout
[287.271091] Starting dynamic subtest: vecs0
[296.965072] Dynamic subtest vecs0: SUCCESS (9.692s)
[296.974718] Starting dynamic subtest: ccs0
[298.336111] Dynamic subtest ccs0: SUCCESS (1.370s)
[298.344784] Starting dynamic subtest: vcs0
[307.968167] Dynamic subtest vcs0: SUCCESS (9.629s)
[307.977411] Starting dynamic subtest: bcs0
[309.242601] Dynamic subtest bcs0: SUCCESS (1.274s)
[309.252871] Starting dynamic subtest: rcs0
[310.552260] Dynamic subtest rcs0: SUCCESS (1.309s)
[310.562877] Starting dynamic subtest: vcs1
[319.947666] Dynamic subtest vcs1: SUCCESS (9.393s)
[319.950081] Subtest timeout: SUCCESS (32.675s)
[320.018704] [051/130] (697s left) kms_psr (psr2-sprite-plane-onoff)
[320.127908] Starting subtest: psr2-sprite-plane-onoff
[320.130566] Starting dynamic subtest: eDP-1
[321.907748] Dynamic subtest eDP-1: SUCCESS (1.779s)
[321.910190] Subtest psr2-sprite-plane-onoff: SUCCESS (1.780s)
[322.758286] [052/130] (695s left) kms_dsc (dsc-with-output-formats-with-bpc)
[322.869329] Starting subtest: dsc-with-output-formats-with-bpc
[322.928583] Subtest dsc-with-output-formats-with-bpc: SKIP (0.001s)
[322.960093] [053/130] (694s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[323.028043] Starting subtest: invalid-multi-wait-all-unsubmitted
[323.030445] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[323.144175] [054/130] (694s left) gem_exec_reloc (basic-gtt)
[323.212519] Subtest basic-gtt: SKIP (0.000s)
[323.283987] [055/130] (694s left) drm_fdinfo (basics)
[323.323767] Starting subtest: basics
[323.325737] Subtest basics: SUCCESS (0.000s)
[323.391108] [056/130] (694s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[323.496254] Starting subtest: psr-2p-primscrn-spr-indfb-move
[323.500965] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[323.568203] [057/130] (694s left) i915_query (query-topology-coherent-slice-mask)
[323.628722] Starting subtest: query-topology-coherent-slice-mask
[323.633212] Subtest query-topology-coherent-slice-mask: SKIP (0.000s)
[323.717376] [058/130] (694s left) kms_sequence (get-idle)
[323.805707] Starting subtest: get-idle
[323.807733] Starting dynamic subtest: pipe-A-eDP-1
[325.630872] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.823s)
[325.640067] Starting dynamic subtest: pipe-B-eDP-1
[328.121553] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.490s)
[328.129218] Starting dynamic subtest: pipe-C-eDP-1
[330.537464] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.415s)
[330.546101] Starting dynamic subtest: pipe-D-eDP-1
[332.960954] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.421s)
[332.963749] Subtest get-idle: SUCCESS (9.153s)
[333.760760] [059/130] (684s left) gem_exec_balancer (semaphore)
[333.820411] Starting subtest: semaphore
[335.937798] Subtest semaphore: SUCCESS (2.115s)
[336.248767] [060/130] (681s left) gem_mmap_offset (pf-nonblock)
[336.316090] Starting subtest: pf-nonblock
[336.325163] Subtest pf-nonblock: SUCCESS (0.012s)
[336.416698] [061/130] (681s left) kms_flip (dpms-off-confusion)
[336.523314] Starting subtest: dpms-off-confusion
[336.525586] Starting dynamic subtest: A-eDP1
[345.168711] Dynamic subtest A-eDP1: SUCCESS (8.644s)
[345.179241] Starting dynamic subtest: B-eDP1
[353.892514] Dynamic subtest B-eDP1: SUCCESS (8.723s)
[353.900344] Starting dynamic subtest: C-eDP1
[362.609486] Dynamic subtest C-eDP1: SUCCESS (8.715s)
[362.618082] Starting dynamic subtest: D-eDP1
[371.336541] Dynamic subtest D-eDP1: SUCCESS (8.727s)
[371.342264] Subtest dpms-off-confusion: SUCCESS (34.817s)
[372.507699] [062/130] (645s left) gem_flink_race (flink_close)
[372.542384] Starting subtest: flink_close
[377.649291] Subtest flink_close: SUCCESS (5.104s)
[377.727438] [063/130] (640s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[377.832501] Starting subtest: psr-modesetfrombusy
[381.884372] Subtest psr-modesetfrombusy: SUCCESS (4.057s)
[382.050028] [064/130] (636s left) gem_exec_fence (invalid-fence-array)
[382.511306] Starting subtest: invalid-fence-array
[382.513544] Subtest invalid-fence-array: SUCCESS (0.002s)
[384.009340] [065/130] (634s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[384.109140] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[384.111484] Starting dynamic subtest: pipe-A-eDP-1
[384.133935] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[384.145070] Starting dynamic subtest: pipe-B-eDP-1
[384.166044] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[384.174070] Starting dynamic subtest: pipe-C-eDP-1
[384.195732] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[384.203554] Starting dynamic subtest: pipe-D-eDP-1
[384.225986] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[384.230100] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.005s)
[386.251773] [066/130] (631s left) kms_pipe_crc_basic (read-crc)
[386.363299] Starting subtest: read-crc
[386.365603] Starting dynamic subtest: pipe-A-eDP-1
[387.057976] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.692s)
[387.066594] Starting dynamic subtest: pipe-B-eDP-1
[388.399869] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.340s)
[388.408897] Starting dynamic subtest: pipe-C-eDP-1
[389.690233] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.288s)
[389.701584] Starting dynamic subtest: pipe-D-eDP-1
[391.014065] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.323s)
[391.016362] Subtest read-crc: SUCCESS (4.649s)
[391.868232] [067/130] (626s left) kms_chamelium_hpd (vga-hpd-fast)
[392.254323] Subtest vga-hpd-fast: SKIP (0.000s)
[393.067573] [068/130] (625s left) gem_lmem_swapping (random-engines)
[393.109668] Subtest random-engines: SKIP (0.000s)
[393.151430] [069/130] (625s left) core_getclient
[393.294360] [070/130] (625s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[393.349638] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[393.354236] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SKIP (0.000s)
[393.526522] [071/130] (624s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[393.625742] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[397.089664] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (3.468s)
[397.232341] [072/130] (621s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[397.332699] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[397.334628] Starting dynamic subtest: pipe-A-default-mode
[400.020722] Dynamic subtest pipe-A-default-mode: SUCCESS (2.683s)
[400.022905] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (2.684s)
[400.880851] [073/130] (617s left) gem_create (create-ext-placement-each)
[401.049431] Starting subtest: create-ext-placement-each
[401.052628] Subtest create-ext-placement-each: SUCCESS (0.000s)
[401.147722] [074/130] (617s left) gem_mmap_wc (write-wc-read-gtt)
[401.212668] Subtest write-wc-read-gtt: SKIP (0.000s)
[401.260399] [075/130] (617s left) kms_chamelium_audio (dp-audio)
[401.640345] Subtest dp-audio: SKIP (0.000s)
[402.480889] [076/130] (616s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[402.594638] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[407.163026] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (4.571s)
[407.295354] [077/130] (611s left) kms_force_connector_basic (force-connector-state)
[407.381600] Starting subtest: force-connector-state
[407.961509] Subtest force-connector-state: SUCCESS (0.580s)
[408.882862] [078/130] (609s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[408.988047] Starting subtest: y-tiled-8bpp-rotate-90
[408.992432] Subtest y-tiled-8bpp-rotate-90: SKIP (0.000s)
[409.094037] [079/130] (609s left) kms_pm_rpm (system-suspend-modeset)
[411.026866] Starting subtest: system-suspend-modeset
[431.366309] Subtest system-suspend-modeset: SUCCESS (4.726s)
[431.705129] [080/130] (602s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[431.822041] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[431.826906] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.001s)
[431.914592] [081/130] (602s left) kms_getfb (getfb-addfb-different-handles)
[431.968645] Starting subtest: getfb-addfb-different-handles
[431.971030] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[432.079353] [082/130] (602s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[432.175609] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[432.179985] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[432.273250] [083/130] (602s left) i915_suspend (fence-restore-tiled2untiled)
[432.323964] Starting subtest: fence-restore-tiled2untiled
[432.328413] Subtest fence-restore-tiled2untiled: SKIP (0.000s)
[432.437607] [084/130] (601s left) kms_pm_backlight (bad-brightness)
[432.534595] Starting subtest: bad-brightness
[432.594664] Starting dynamic subtest: eDP-1
[432.904676] Dynamic subtest eDP-1: SUCCESS (0.316s)
[432.907065] Subtest bad-brightness: SUCCESS (0.380s)
[433.707811] [085/130] (600s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[433.808655] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[433.810831] Starting dynamic subtest: pipe-A
[433.825862] Dynamic subtest pipe-A: SKIP (0.011s)
[433.835295] Starting dynamic subtest: pipe-B
[433.844294] Dynamic subtest pipe-B: SKIP (0.020s)
[433.853232] Starting dynamic subtest: pipe-C
[433.865769] Dynamic subtest pipe-C: SKIP (0.020s)
[433.880443] Starting dynamic subtest: pipe-D
[433.889340] Dynamic subtest pipe-D: SKIP (0.020s)
[433.893344] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (0.073s)
[433.959924] [086/130] (600s left) kms_vblank (ts-continuation-dpms-suspend)
[434.050852] Starting subtest: ts-continuation-dpms-suspend
[434.053081] Starting dynamic subtest: pipe-A-eDP-1
[451.386436] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.879s)
[451.401157] Starting dynamic subtest: pipe-D-eDP-1
[469.089632] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.242s)
[469.091804] Subtest ts-continuation-dpms-suspend: SUCCESS (4.125s)
[469.882143] [087/130] (595s left) i915_pciid
[470.029969] [088/130] (595s left) gem_exec_schedule (preempt-user)
[470.107743] Starting subtest: preempt-user
[470.109692] Starting dynamic subtest: rcs0
[470.123996] Dynamic subtest rcs0: SUCCESS (0.024s)
[470.135116] Starting dynamic subtest: bcs0
[470.143088] Dynamic subtest bcs0: SUCCESS (0.019s)
[470.151734] Starting dynamic subtest: vcs0
[470.161928] Dynamic subtest vcs0: SUCCESS (0.018s)
[470.171340] Starting dynamic subtest: vcs1
[470.179228] Dynamic subtest vcs1: SUCCESS (0.018s)
[470.187854] Starting dynamic subtest: vecs0
[470.197266] Dynamic subtest vecs0: SUCCESS (0.018s)
[470.205839] Starting dynamic subtest: ccs0
[470.217835] Dynamic subtest ccs0: SUCCESS (0.021s)
[470.219924] Subtest preempt-user: SUCCESS (0.122s)
[471.700240] [089/130] (593s left) kms_chamelium_hpd (dp-hpd)
[472.074005] Subtest dp-hpd: SKIP (0.000s)
[472.877004] [090/130] (592s left) syncobj_basic (bad-destroy)
[472.934019] Starting subtest: bad-destroy
[472.936303] Subtest bad-destroy: SUCCESS (0.000s)
[473.046674] [091/130] (592s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[473.165770] Starting subtest: flip-vs-cursor-legacy
[479.841281] Subtest flip-vs-cursor-legacy: SUCCESS (6.773s)
[480.677500] [092/130] (584s left) kms_psr (fbc-psr2-suspend)
[480.778160] Starting subtest: fbc-psr2-suspend
[480.780124] Starting dynamic subtest: eDP-1
[480.784283] Dynamic subtest eDP-1: SKIP (0.000s)
[480.788307] Subtest fbc-psr2-suspend: SKIP (0.001s)
[480.842401] [093/130] (584s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[480.957583] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[480.961794] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[481.074808] [094/130] (584s left) perf_pmu (rc6)
[481.116840] Starting subtest: rc6
[481.119051] Starting dynamic subtest: gt0
[487.472180] Dynamic subtest gt0: SUCCESS (6.391s)
[487.483409] Starting dynamic subtest: runtime-pm-gt0
[495.189509] Dynamic subtest runtime-pm-gt0: SUCCESS (7.735s)
[495.201383] Starting dynamic subtest: runtime-pm-long-gt0
[507.645957] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.448s)
[507.657892] Starting dynamic subtest: other-idle-gt0
[513.995543] Dynamic subtest other-idle-gt0: SUCCESS (6.343s)
[514.007122] Starting dynamic subtest: gt1
[520.340382] Dynamic subtest gt1: SUCCESS (6.340s)
[520.357614] Starting dynamic subtest: runtime-pm-gt1
[527.775660] Dynamic subtest runtime-pm-gt1: SUCCESS (7.432s)
[527.787862] Starting dynamic subtest: runtime-pm-long-gt1
[540.199867] Dynamic subtest runtime-pm-long-gt1: SUCCESS (12.423s)
[540.211546] Starting dynamic subtest: other-idle-gt1
[546.547717] Dynamic subtest other-idle-gt1: SUCCESS (6.347s)
[546.551042] Subtest rc6: SUCCESS (65.474s)
[547.663416] [095/130] (517s left) debugfs_test (read_all_entries_display_on)
[547.756400] Starting subtest: read_all_entries_display_on
[548.142080] Subtest read_all_entries_display_on: SUCCESS (0.386s)
[548.245257] [096/130] (517s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[548.348617] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[552.869859] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.524s)
[552.989293] [097/130] (512s left) kms_cursor_edge_walk (64x64-top-bottom)
[553.082404] Starting subtest: 64x64-top-bottom
[553.084613] Starting dynamic subtest: pipe-A-eDP-1
[556.557678] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[556.567530] Starting dynamic subtest: pipe-D-eDP-1
[559.730692] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.173s)
[559.733046] Subtest 64x64-top-bottom: SUCCESS (6.650s)
[560.501767] [098/130] (505s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[560.604820] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[565.422690] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (4.820s)
[565.523344] [099/130] (500s left) gem_ctx_shared (single-timeline)
[565.587248] Starting subtest: single-timeline
[565.607603] Subtest single-timeline: SUCCESS (0.013s)
[565.810637] [100/130] (499s left) api_intel_allocator (fork-simple-stress)
[565.857968] Starting subtest: fork-simple-stress
[571.264136] Subtest fork-simple-stress: SUCCESS (5.406s)
[571.337870] [101/130] (494s left) kms_cursor_crc (cursor-random-32x10)
[571.491084] Starting subtest: cursor-random-32x10
[571.528584] Subtest cursor-random-32x10: SKIP (0.033s)
[571.783740] [102/130] (493s left) kms_chamelium_edid (hdmi-edid-read)
[572.176596] Subtest hdmi-edid-read: SKIP (0.000s)
[573.002154] [103/130] (492s left) gem_eio (wait-wedge-immediate)
[573.236987] Starting subtest: wait-wedge-immediate
[574.685356] Subtest wait-wedge-immediate: SUCCESS (1.447s)
[574.823144] [104/130] (490s left) gem_ctx_shared (exec-shared-gtt)
[574.899308] Starting subtest: exec-shared-gtt
[574.901404] Starting dynamic subtest: rcs0
[574.906247] Dynamic subtest rcs0: SUCCESS (0.008s)
[574.919314] Starting dynamic subtest: bcs0
[574.921255] Dynamic subtest bcs0: SUCCESS (0.005s)
[574.931017] Starting dynamic subtest: vcs0
[574.933231] Dynamic subtest vcs0: SUCCESS (0.007s)
[574.941787] Starting dynamic subtest: vcs1
[574.944280] Dynamic subtest vcs1: SUCCESS (0.006s)
[574.954649] Starting dynamic subtest: vecs0
[574.956860] Dynamic subtest vecs0: SUCCESS (0.008s)
[574.965261] Starting dynamic subtest: ccs0
[574.967551] Dynamic subtest ccs0: SUCCESS (0.008s)
[574.969857] Subtest exec-shared-gtt: SUCCESS (0.044s)
[575.101005] [105/130] (490s left) perf (invalid-oa-format-id)
[575.162402] Starting subtest: invalid-oa-format-id
[575.177739] Subtest invalid-oa-format-id: SUCCESS (0.013s)
[575.220705] [106/130] (490s left) gem_fenced_exec_thrash (2-spare-fences)
[575.280850] Subtest 2-spare-fences: SKIP (0.000s)
[575.371679] [107/130] (490s left) kms_flip (dpms-vs-vblank-race)
[575.471322] Starting subtest: dpms-vs-vblank-race
[575.473706] Starting dynamic subtest: A-eDP1
[579.385320] Dynamic subtest A-eDP1: SUCCESS (3.912s)
[579.394767] Starting dynamic subtest: B-eDP1
[582.889446] Dynamic subtest B-eDP1: SUCCESS (3.500s)
[582.898743] Starting dynamic subtest: C-eDP1
[586.372310] Dynamic subtest C-eDP1: SUCCESS (3.484s)
[586.383493] Starting dynamic subtest: D-eDP1
[589.875877] Dynamic subtest D-eDP1: SUCCESS (3.503s)
[589.878295] Subtest dpms-vs-vblank-race: SUCCESS (14.407s)
[590.702424] [108/130] (475s left) kms_async_flips (invalid-async-flip)
[590.791058] Starting subtest: invalid-async-flip
[590.795596] Subtest invalid-async-flip: SKIP (0.000s)
[592.004403] [109/130] (473s left) gen7_exec_parse (basic-offset)
[592.077608] Subtest basic-offset: SKIP (0.000s)
[592.170284] [110/130] (473s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[592.276311] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[592.280559] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[592.373988] [111/130] (473s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[592.429660] Starting subtest: invalid-signal-one-illegal-handle
[592.431964] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[592.490309] [112/130] (473s left) i915_pm_rpm (gem-idle)
[594.828096] Starting subtest: gem-idle
[601.042683] Subtest gem-idle: SUCCESS (6.216s)
[601.334382] [113/130] (464s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[602.597369] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[602.599758] Starting dynamic subtest: pipe-A-default-mode
[602.883105] Dynamic subtest pipe-A-default-mode: SKIP (0.282s)
[602.887699] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.283s)
[603.698030] [114/130] (462s left) kms_invalid_mode (zero-hdisplay)
[603.795173] Starting subtest: zero-hdisplay
[603.797436] Starting dynamic subtest: pipe-A-eDP-1
[604.081334] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[604.090093] Starting dynamic subtest: pipe-B-eDP-1
[604.091992] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[604.100082] Starting dynamic subtest: pipe-C-eDP-1
[604.101961] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[604.110370] Starting dynamic subtest: pipe-D-eDP-1
[604.112528] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[604.114695] Subtest zero-hdisplay: SUCCESS (0.293s)
[604.900248] [115/130] (461s left) gem_mmap_wc (copy)
[604.952866] Subtest copy: SKIP (0.000s)
[605.012585] [116/130] (461s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[605.124337] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[613.256137] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.129s)
[614.099452] [117/130] (452s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[614.640748] Starting subtest: syncobj-stationary-timeline-chain-engines
[614.751752] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.111s)
[615.709461] [118/130] (450s left) kms_psr (pr-cursor-plane-onoff)
[615.793607] Starting subtest: pr-cursor-plane-onoff
[615.798399] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[615.837216] [119/130] (450s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[615.940430] Starting subtest: fbc-tiling-linear
[618.651481] Subtest fbc-tiling-linear: SUCCESS (2.715s)
[618.770743] [120/130] (447s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[618.869320] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[618.872906] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[618.958215] [121/130] (447s left) gem_exec_params (invalid-fence-in)
[619.019283] Starting subtest: invalid-fence-in
[619.021453] Subtest invalid-fence-in: SUCCESS (0.000s)
[619.114584] [122/130] (447s left) gem_exec_params (rs-invalid)
[619.164897] Starting subtest: rs-invalid
[619.170066] Subtest rs-invalid: SUCCESS (0.003s)
[619.291577] [123/130] (447s left) kms_flip (flip-vs-absolute-wf_vblank)
[619.392637] Starting subtest: flip-vs-absolute-wf_vblank
[619.394737] Starting dynamic subtest: A-eDP1
[628.336786] Dynamic subtest A-eDP1: SUCCESS (8.944s)
[628.347003] Starting dynamic subtest: B-eDP1
[637.234641] Dynamic subtest B-eDP1: SUCCESS (8.896s)
[637.245745] Starting dynamic subtest: C-eDP1
[646.123322] Dynamic subtest C-eDP1: SUCCESS (8.889s)
[646.134474] Starting dynamic subtest: D-eDP1
[655.021081] Dynamic subtest D-eDP1: SUCCESS (8.897s)
[655.023377] Subtest flip-vs-absolute-wf_vblank: SUCCESS (35.635s)
[656.188490] [124/130] (410s left) gem_exec_reloc (basic-gtt-read)
[656.254978] Subtest basic-gtt-read: SKIP (0.000s)
[656.336458] [125/130] (410s left) kms_psr (fbc-pr-sprite-plane-move)
[656.444048] Starting subtest: fbc-pr-sprite-plane-move
[656.448443] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[656.485045] [126/130] (410s left) core_getstats
[656.619991] [127/130] (409s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[656.721573] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[656.725886] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[656.787653] [128/130] (409s left) kms_cursor_crc (cursor-sliding-256x256)
[657.010843] Starting subtest: cursor-sliding-256x256
[657.015657] Starting dynamic subtest: pipe-A-eDP-1
[660.509259] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.495s)
[660.540405] Starting dynamic subtest: pipe-D-eDP-1
[664.659775] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.129s)
[664.662087] Subtest cursor-sliding-256x256: SUCCESS (7.651s)
[665.482245] [129/130] (401s left) gem_userptr_blits (mmap-offset-banned)
[665.546103] Starting subtest: mmap-offset-banned
[665.548268] Starting dynamic subtest: wb
[665.550461] Dynamic subtest wb: SUCCESS (0.000s)
[665.559290] Starting dynamic subtest: wc
[665.561169] Dynamic subtest wc: SUCCESS (0.000s)
[665.569078] Starting dynamic subtest: uc
[665.570996] Dynamic subtest uc: SUCCESS (0.000s)
[665.572871] Subtest mmap-offset-banned: SUCCESS (0.002s)
[665.657436] [130/130] (400s left) prime_mmap (test_correct)
[665.714051] Starting subtest: test_correct
[665.716287] Starting dynamic subtest: test_correct-smem
[665.739145] Dynamic subtest test_correct-smem: SUCCESS (0.031s)
[665.741718] Subtest test_correct: SUCCESS (0.032s)
[665.815295] Closing watchdogs
Done.