[54.791505] Initializing watchdogs
[54.791663]   /dev/watchdog0
[54.807627] [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]
[54.811800] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[54.813960] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[54.817229] [001/131] (960s left) kms_async_flips (alternate-sync-async-flip)
[54.933921] Starting subtest: alternate-sync-async-flip
[55.317491] Starting dynamic subtest: pipe-A-eDP-1
[58.101369] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.724s)
[58.470281] Starting dynamic subtest: pipe-B-eDP-1
[61.275767] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.771s)
[61.650182] Starting dynamic subtest: pipe-C-eDP-1
[64.456235] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.787s)
[64.822299] Starting dynamic subtest: pipe-D-eDP-1
[67.600079] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.766s)
[67.602597] Subtest alternate-sync-async-flip: SUCCESS (12.500s)
[68.796131] [002/131] (946s left) gem_exec_params (no-blt)
[68.863058] Starting subtest: no-blt
[68.867823] Subtest no-blt: SUCCESS (0.002s)
[68.982499] [003/131] (946s left) kms_chamelium_audio (hdmi-audio)
[69.365648] Subtest hdmi-audio: SKIP (0.000s)
[70.198112] [004/131] (945s left) kms_atomic_transition (plane-all-transition-fencing)
[70.297472] Starting subtest: plane-all-transition-fencing
[70.299959] Starting dynamic subtest: pipe-A-eDP-1
[72.818594] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.513s)
[73.124457] Starting dynamic subtest: pipe-B-eDP-1
[76.365223] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.243s)
[76.675970] Subtest plane-all-transition-fencing: SUCCESS (6.360s)
[77.489075] [005/131] (937s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[77.607180] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[84.557493] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (6.948s)
[84.667762] [006/131] (930s left) gem_exec_schedule (submit-late-slice)
[84.742472] Starting subtest: submit-late-slice
[84.744474] Starting dynamic subtest: rcs0
[84.768496] Dynamic subtest rcs0: SUCCESS (0.034s)
[84.779624] Starting dynamic subtest: bcs0
[84.801705] Dynamic subtest bcs0: SUCCESS (0.033s)
[84.809665] Starting dynamic subtest: vcs0
[84.837909] Dynamic subtest vcs0: SUCCESS (0.036s)
[84.846921] Starting dynamic subtest: vcs1
[84.867843] Dynamic subtest vcs1: SUCCESS (0.029s)
[84.875163] Starting dynamic subtest: vecs0
[84.897794] Dynamic subtest vecs0: SUCCESS (0.030s)
[84.904853] Starting dynamic subtest: ccs0
[84.930963] Dynamic subtest ccs0: SUCCESS (0.033s)
[84.933319] Subtest submit-late-slice: SUCCESS (0.197s)
[86.001884] [007/131] (929s left) prime_mmap (test_forked)
[86.057545] Starting subtest: test_forked
[86.059940] Starting dynamic subtest: test_forked-smem
[86.093355] Dynamic subtest test_forked-smem: SUCCESS (0.038s)
[86.095832] Subtest test_forked: SUCCESS (0.039s)
[86.191734] [008/131] (929s left) gem_tiling_max_stride
[86.322973] [009/131] (929s left) gem_exec_whisper (basic-queues-all)
[86.384255] Starting subtest: basic-queues-all
[97.903497] Subtest basic-queues-all: SUCCESS (11.516s)
[98.076042] [010/131] (917s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite)
[98.195039] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite
[98.199379] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s)
[98.296263] [011/131] (917s left) kms_big_fb (4-tiled-64bpp-rotate-90)
[98.412122] Starting subtest: 4-tiled-64bpp-rotate-90
[98.433339] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s)
[98.575282] [012/131] (917s left) syncobj_timeline (invalid-signal-zero-handles)
[98.630484] Starting subtest: invalid-signal-zero-handles
[98.632739] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[98.748847] [013/131] (917s left) gen7_exec_parse (chained-batch)
[98.814512] Subtest chained-batch: SKIP (0.000s)
[98.881577] [014/131] (916s left) kms_big_fb (yf-tiled-8bpp-rotate-90)
[98.987339] Starting subtest: yf-tiled-8bpp-rotate-90
[98.991579] Subtest yf-tiled-8bpp-rotate-90: SKIP (0.000s)
[99.079294] [015/131] (916s left) sw_sync (sync_random_merge)
[99.110636] Starting subtest: sync_random_merge
[99.147903] Subtest sync_random_merge: SUCCESS (0.038s)
[99.203401] [016/131] (916s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-blt)
[99.286319] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-blt
[99.289933] Subtest fbc-2p-scndscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[99.394336] [017/131] (916s left) gem_exec_reloc (basic-cpu-gtt)
[99.459059] Subtest basic-cpu-gtt: SKIP (0.000s)
[99.548163] [018/131] (916s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[99.603090] Starting subtest: etime-single-wait-for-submit-submitted
[99.712814] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[99.784590] [019/131] (916s left) gem_userptr_blits (coherency-sync)
[99.852246] Starting subtest: coherency-sync
[100.114677] Subtest coherency-sync: SKIP (0.225s)
[100.246958] [020/131] (915s left) kms_content_protection (atomic-dpms)
[100.464496] Starting subtest: atomic-dpms
[103.827808] Subtest atomic-dpms: SKIP (3.361s)
[104.991603] [021/131] (911s left) kms_cursor_crc (cursor-random-max-size)
[105.307809] Starting subtest: cursor-random-max-size
[105.314915] Subtest cursor-random-max-size: SKIP (0.000s)
[105.441093] [022/131] (910s left) kms_big_fb (y-tiled-16bpp-rotate-180)
[105.550991] Starting subtest: y-tiled-16bpp-rotate-180
[105.555178] Subtest y-tiled-16bpp-rotate-180: SKIP (0.000s)
[105.658925] [023/131] (910s left) gem_eio (in-flight-1us)
[105.882324] Starting subtest: in-flight-1us
[114.952258] Subtest in-flight-1us: SUCCESS (9.069s)
[115.121837] [FACT gem_eio (in-flight-1us)] new: kernel.kmod_is_loaded.vgem: true
[115.125105] [024/131] (901s left) i915_fb_tiling (basic-x-tiling)
[115.185866] Subtest basic-x-tiling: SKIP (0.000s)
[115.248757] [025/131] (900s left) kms_busy (extended-modeset-hang-oldfb)
[115.349062] Starting subtest: extended-modeset-hang-oldfb
[115.351488] Starting dynamic subtest: pipe-A
[126.868674] Dynamic subtest pipe-A: SUCCESS (11.518s)
[126.878245] Starting dynamic subtest: pipe-D
[139.215284] Dynamic subtest pipe-D: SUCCESS (12.342s)
[139.217801] Subtest extended-modeset-hang-oldfb: SUCCESS (23.864s)
[139.993175] [026/131] (876s left) kms_plane_cursor (viewport)
[140.105348] Starting subtest: viewport
[140.109450] Starting dynamic subtest: pipe-A-eDP-1-size-64
[143.009912] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.905s)
[143.069825] Starting dynamic subtest: pipe-A-eDP-1-size-128
[146.033675] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.971s)
[146.095888] Starting dynamic subtest: pipe-A-eDP-1-size-256
[149.089978] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (3.003s)
[149.442864] Starting dynamic subtest: pipe-B-eDP-1-size-64
[152.992601] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.564s)
[153.054592] Starting dynamic subtest: pipe-B-eDP-1-size-128
[155.951218] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.905s)
[156.009849] Starting dynamic subtest: pipe-B-eDP-1-size-256
[158.952677] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.948s)
[159.300830] Starting dynamic subtest: pipe-C-eDP-1-size-64
[162.519726] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.229s)
[162.557266] Starting dynamic subtest: pipe-C-eDP-1-size-128
[165.040820] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.491s)
[165.084206] Starting dynamic subtest: pipe-C-eDP-1-size-256
[167.586153] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.513s)
[167.913820] Starting dynamic subtest: pipe-D-eDP-1-size-64
[171.200141] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.296s)
[171.238513] Starting dynamic subtest: pipe-D-eDP-1-size-128
[173.756084] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.523s)
[173.793127] Starting dynamic subtest: pipe-D-eDP-1-size-256
[176.233033] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.446s)
[176.556756] Subtest viewport: SUCCESS (36.450s)
[177.393268] [027/131] (838s left) api_intel_bb (blit-reloc-purge-cache)
[177.459291] Starting subtest: blit-reloc-purge-cache
[177.463631] Subtest blit-reloc-purge-cache: SKIP (0.000s)
[177.588389] [028/131] (838s left) gem_spin_batch (resubmit-new-all)
[177.649938] Starting subtest: resubmit-new-all
[177.652217] Starting dynamic subtest: rcs0
[177.664033] Dynamic subtest rcs0: SUCCESS (0.014s)
[177.672499] Starting dynamic subtest: bcs0
[177.677503] Dynamic subtest bcs0: SUCCESS (0.012s)
[177.685386] Starting dynamic subtest: vcs0
[177.687714] Dynamic subtest vcs0: SUCCESS (0.010s)
[177.695875] Starting dynamic subtest: vcs1
[177.698308] Dynamic subtest vcs1: SUCCESS (0.009s)
[177.712393] Starting dynamic subtest: vecs0
[177.714532] Dynamic subtest vecs0: SUCCESS (0.009s)
[177.722452] Starting dynamic subtest: ccs0
[177.724301] Dynamic subtest ccs0: SUCCESS (0.013s)
[177.726123] Subtest resubmit-new-all: SUCCESS (0.070s)
[178.937646] [029/131] (837s left) kms_rotation_crc (primary-yf-tiled-reflect-x-270)
[179.036240] Starting subtest: primary-yf-tiled-reflect-x-270
[179.040603] Subtest primary-yf-tiled-reflect-x-270: SKIP (0.001s)
[179.107918] [030/131] (837s left) kms_psr (fbc-pr-cursor-mmap-gtt)
[179.206153] Starting subtest: fbc-pr-cursor-mmap-gtt
[179.210154] Subtest fbc-pr-cursor-mmap-gtt: SKIP (0.000s)
[179.277309] [031/131] (837s left) gem_ctx_isolation (nonpriv-switch)
[179.329604] Starting subtest: nonpriv-switch
[179.332245] Starting dynamic subtest: rcs0
[179.909997] Dynamic subtest rcs0: SUCCESS (0.580s)
[179.919511] Starting dynamic subtest: bcs0
[180.556905] Dynamic subtest bcs0: SUCCESS (0.646s)
[180.568095] Starting dynamic subtest: vcs0
[181.196377] Dynamic subtest vcs0: SUCCESS (0.639s)
[181.204959] Starting dynamic subtest: vcs1
[182.531879] Dynamic subtest vcs1: SUCCESS (1.334s)
[182.541287] Starting dynamic subtest: vecs0
[184.515200] Dynamic subtest vecs0: SUCCESS (1.982s)
[184.526090] Starting dynamic subtest: ccs0
[186.513169] Dynamic subtest ccs0: SUCCESS (1.996s)
[186.516054] Subtest nonpriv-switch: SUCCESS (7.182s)
[186.739264] [032/131] (829s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[186.832375] Starting subtest: drrs-dirtyfb-ioctl
[186.845343] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[186.948505] [033/131] (829s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[187.049650] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[188.340588] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.292s)
[188.633391] [034/131] (827s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[188.741631] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[188.745838] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[188.862470] [035/131] (827s left) kms_mmap_write_crc (main)
[188.967273] Starting subtest: main
[188.969578] Starting dynamic subtest: pipe-A-eDP-1
[192.469087] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.500s)
[192.472091] Subtest main: SUCCESS (3.501s)
[193.316568] [036/131] (823s left) i915_pm_rc6_residency (media-rc6-accuracy)
[193.380785] Starting subtest: media-rc6-accuracy
[193.385289] Subtest media-rc6-accuracy: SKIP (0.000s)
[193.496852] [037/131] (823s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[193.598941] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[194.867566] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (1.270s)
[195.119940] [038/131] (821s left) sysfs_heartbeat_interval (invalid)
[195.175186] Starting subtest: invalid
[195.177498] Starting dynamic subtest: vecs0
[195.179748] Dynamic subtest vecs0: SUCCESS (0.000s)
[195.189853] Starting dynamic subtest: ccs0
[195.191988] Dynamic subtest ccs0: SUCCESS (0.000s)
[195.200558] Starting dynamic subtest: vcs0
[195.202867] Dynamic subtest vcs0: SUCCESS (0.000s)
[195.211055] Starting dynamic subtest: bcs0
[195.213724] Dynamic subtest bcs0: SUCCESS (0.000s)
[195.221668] Starting dynamic subtest: rcs0
[195.223755] Dynamic subtest rcs0: SUCCESS (0.000s)
[195.231746] Starting dynamic subtest: vcs1
[195.233791] Dynamic subtest vcs1: SUCCESS (0.000s)
[195.236037] Subtest invalid: SUCCESS (0.004s)
[195.295258] [039/131] (821s left) dumb_buffer (map-uaf)
[195.361112] Starting subtest: map-uaf
[195.373873] Subtest map-uaf: SUCCESS (0.016s)
[195.488523] [040/131] (821s left) gem_mmap_wc (bad-size)
[195.543810] Subtest bad-size: SKIP (0.000s)
[195.604240] [041/131] (821s left) kms_atomic_interruptible (universal-setplane-primary)
[195.690212] Starting subtest: universal-setplane-primary
[195.692588] Starting dynamic subtest: pipe-A-eDP-1
[203.129817] Dynamic subtest pipe-A-eDP-1: SUCCESS (7.439s)
[203.131771] Subtest universal-setplane-primary: SUCCESS (7.441s)
[203.960930] [042/131] (812s left) kms_frontbuffer_tracking (psr-2p-rte)
[204.078871] Starting subtest: psr-2p-rte
[204.083256] Subtest psr-2p-rte: SKIP (0.000s)
[204.175159] [043/131] (812s left) gem_close_race (multigpu-basic-threads)
[204.240554] Starting subtest: multigpu-basic-threads
[204.245017] Subtest multigpu-basic-threads: SKIP (0.000s)
[204.477938] [044/131] (812s left) gen9_exec_parse (secure-batches)
[204.537509] Subtest secure-batches: SKIP (0.000s)
[204.605946] [045/131] (812s left) kms_ccs (crc-primary-basic-yf-tiled-ccs)
[204.700162] Starting subtest: crc-primary-basic-yf-tiled-ccs
[204.702451] Starting dynamic subtest: pipe-A-eDP-1
[204.726060] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[204.737174] Starting dynamic subtest: pipe-B-eDP-1
[204.759066] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[204.768034] Starting dynamic subtest: pipe-C-eDP-1
[204.789803] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[204.799098] Starting dynamic subtest: pipe-D-eDP-1
[204.823058] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[204.827420] Subtest crc-primary-basic-yf-tiled-ccs: SKIP (0.005s)
[206.820902] [046/131] (810s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render)
[206.927784] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render
[206.931908] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[207.047973] [047/131] (810s left) kms_selftest (drm_plane_helper)
[207.087491] Starting subtest: drm_plane_helper
[207.120961] Starting dynamic subtest: drm_test_check_plane_state
[207.277344] Dynamic subtest drm_test_check_plane_state: SUCCESS (0.156s)
[207.285303] Starting dynamic subtest: drm_test_check_invalid_plane_state
[207.415279] Dynamic subtest drm_test_check_invalid_plane_state: SUCCESS (0.137s)
[207.417317] Subtest drm_plane_helper: SUCCESS (0.326s)
[207.618944] [048/131] (809s left) prime_self_import (export-vs-gem_close-race)
[207.652631] Starting subtest: export-vs-gem_close-race
[212.756679] Subtest export-vs-gem_close-race: SUCCESS (5.095s)
[212.824237] [049/131] (804s left) kms_plane_scaling (planes-unity-scaling-downscale-factor-0-75)
[212.924820] Starting subtest: planes-unity-scaling-downscale-factor-0-75
[212.927188] Starting dynamic subtest: pipe-A
[213.009746] Dynamic subtest pipe-A: SUCCESS (0.084s)
[213.019539] Starting dynamic subtest: pipe-B
[214.136107] Dynamic subtest pipe-B: SUCCESS (1.124s)
[214.147456] Starting dynamic subtest: pipe-C
[215.233063] Dynamic subtest pipe-C: SUCCESS (1.096s)
[215.247172] Starting dynamic subtest: pipe-D
[216.351189] Dynamic subtest pipe-D: SUCCESS (1.117s)
[216.353516] Subtest planes-unity-scaling-downscale-factor-0-75: SUCCESS (3.426s)
[217.510653] [050/131] (799s left) gem_exec_schedule (preempt-engines)
[217.586765] Starting subtest: preempt-engines
[217.589145] Starting dynamic subtest: rcs0
[219.862425] Dynamic subtest rcs0: SUCCESS (2.230s)
[219.874102] Starting dynamic subtest: bcs0
[222.073608] Dynamic subtest bcs0: SUCCESS (2.211s)
[222.085643] Starting dynamic subtest: vcs0
[224.340487] Dynamic subtest vcs0: SUCCESS (2.265s)
[224.352298] Starting dynamic subtest: vcs1
[226.597412] Dynamic subtest vcs1: SUCCESS (2.256s)
[226.608685] Starting dynamic subtest: vecs0
[228.845867] Dynamic subtest vecs0: SUCCESS (2.246s)
[228.857566] Starting dynamic subtest: ccs0
[231.173274] Dynamic subtest ccs0: SUCCESS (2.326s)
[231.175784] Subtest preempt-engines: SUCCESS (13.544s)
[231.417834] [051/131] (785s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-onoff)
[231.531425] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-onoff
[231.535420] Subtest fbcpsr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[231.644031] [052/131] (785s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[231.772917] Starting subtest: protected-encrypted-src-copy-not-readible
[231.885242] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.113s)
[232.025456] [053/131] (785s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt)
[232.133088] Starting subtest: fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt
[232.137237] Subtest fbcpsr-1p-offscren-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[232.217441] [054/131] (785s left) prime_busy (after)
[232.274843] Starting subtest: after
[232.279773] Starting dynamic subtest: rcs0
[232.331089] Dynamic subtest rcs0: SUCCESS (0.053s)
[232.340631] Starting dynamic subtest: bcs0
[232.399922] Dynamic subtest bcs0: SUCCESS (0.068s)
[232.408939] Starting dynamic subtest: vcs0
[232.441696] Dynamic subtest vcs0: SUCCESS (0.040s)
[232.451881] Starting dynamic subtest: vcs1
[232.482704] Dynamic subtest vcs1: SUCCESS (0.040s)
[232.492432] Starting dynamic subtest: vecs0
[232.522147] Dynamic subtest vecs0: SUCCESS (0.040s)
[232.530738] Starting dynamic subtest: ccs0
[232.562992] Dynamic subtest ccs0: SUCCESS (0.040s)
[232.671056] Subtest after: SUCCESS (0.394s)
[232.747026] [055/131] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt)
[232.840888] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt
[232.845070] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s)
[232.942574] [056/131] (784s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[233.035764] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[233.039850] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[233.139937] [057/131] (784s left) kms_properties (plane-properties-atomic)
[233.243118] Starting subtest: plane-properties-atomic
[233.245402] Starting dynamic subtest: pipe-A-eDP-1
[233.803745] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.559s)
[233.813653] Starting dynamic subtest: pipe-B-eDP-1
[235.062026] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.257s)
[235.071570] Starting dynamic subtest: pipe-C-eDP-1
[236.296894] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.233s)
[236.306070] Starting dynamic subtest: pipe-D-eDP-1
[237.514809] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.216s)
[237.517371] Subtest plane-properties-atomic: SUCCESS (4.270s)
[238.310882] [058/131] (779s left) gem_exec_fence (submit3)
[238.490968] Starting subtest: submit3
[238.495764] Subtest submit3: SKIP (0.000s)
[239.955014] [059/131] (777s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[240.065210] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[240.069139] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[240.192359] [060/131] (777s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[240.293832] Starting subtest: invalid-modeset-force-ultra-joiner
[240.298641] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[240.363133] [061/131] (777s left) kms_psr (psr-cursor-mmap-cpu)
[240.456344] Starting subtest: psr-cursor-mmap-cpu
[240.458693] Starting dynamic subtest: eDP-1
[242.192168] Dynamic subtest eDP-1: SUCCESS (1.736s)
[242.194647] Subtest psr-cursor-mmap-cpu: SUCCESS (1.738s)
[243.053117] [062/131] (774s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling)
[243.153355] Starting subtest: flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling
[243.155697] Starting dynamic subtest: pipe-A-default-mode
[243.520597] Dynamic subtest pipe-A-default-mode: SKIP (0.363s)
[243.525394] Subtest flip-64bpp-4tile-to-32bpp-4tiledg2rcccs-downscaling: SKIP (0.365s)
[244.272700] [063/131] (773s left) gem_exec_fence (syncobj-unused-fence)
[244.679376] Starting subtest: syncobj-unused-fence
[244.685449] Subtest syncobj-unused-fence: SUCCESS (0.004s)
[246.029307] [064/131] (771s left) gem_mmap_gtt (cpuset-basic-small-copy-xy)
[246.092126] Subtest cpuset-basic-small-copy-XY: SKIP (0.000s)
[246.148217] [065/131] (771s left) gem_workarounds (basic-read-context)
[246.220184] Starting subtest: basic-read-context
[246.232882] Subtest basic-read-context: SUCCESS (0.012s)
[246.349231] [066/131] (771s left) kms_cursor_legacy (cursor-vs-flip-atomic)
[246.459499] Starting subtest: cursor-vs-flip-atomic
[275.720849] Subtest cursor-vs-flip-atomic: SUCCESS (29.260s)
[276.499474] [067/131] (741s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-shrfb-draw-mmap-cpu)
[276.597742] Starting subtest: psr-1p-offscren-pri-shrfb-draw-mmap-cpu
[283.205341] Subtest psr-1p-offscren-pri-shrfb-draw-mmap-cpu: SUCCESS (6.610s)
[283.315897] [068/131] (734s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs)
[283.401440] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs
[283.403829] Starting dynamic subtest: pipe-A-eDP-1
[283.429238] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[283.440731] Starting dynamic subtest: pipe-B-eDP-1
[283.462688] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[283.471823] Starting dynamic subtest: pipe-C-eDP-1
[283.493737] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[283.502501] Starting dynamic subtest: pipe-D-eDP-1
[283.524395] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[283.528466] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[285.657855] [069/131] (732s left) i915_pm_rps (thresholds)
[285.714843] Starting subtest: thresholds
[285.720229] Subtest thresholds: SKIP (0.000s)
[285.803795] [070/131] (732s left) kms_frontbuffer_tracking (psr-slowdraw)
[285.897344] Starting subtest: psr-slowdraw
[310.967547] Subtest psr-slowdraw: SUCCESS (25.073s)
[311.113897] [071/131] (706s left) kms_invalid_mode (zero-hdisplay)
[311.204737] Starting subtest: zero-hdisplay
[311.207080] Starting dynamic subtest: pipe-A-eDP-1
[311.489264] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.283s)
[311.498616] Starting dynamic subtest: pipe-B-eDP-1
[311.500632] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[311.508604] Starting dynamic subtest: pipe-C-eDP-1
[311.510996] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[311.519220] Starting dynamic subtest: pipe-D-eDP-1
[311.521482] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[311.523763] Subtest zero-hdisplay: SUCCESS (0.288s)
[312.270404] [072/131] (705s left) kms_cursor_legacy (flip-vs-cursor-toggle)
[312.395413] Starting subtest: flip-vs-cursor-toggle
[320.420656] Subtest flip-vs-cursor-toggle: SUCCESS (8.025s)
[321.296397] [073/131] (696s left) kms_cursor_crc (cursor-offscreen-64x21)
[321.524631] Starting subtest: cursor-offscreen-64x21
[321.564943] Subtest cursor-offscreen-64x21: SKIP (0.038s)
[321.825106] [074/131] (696s left) perf_pmu (event-wait)
[321.858750] Starting subtest: event-wait
[321.861553] Starting dynamic subtest: rcs0
[321.866103] Dynamic subtest rcs0: SKIP (0.000s)
[321.870533] Subtest event-wait: SKIP (0.000s)
[321.975943] [075/131] (696s left) kms_plane_scaling (plane-scaler-unity-scaling-with-pixel-format)
[322.069082] Starting subtest: plane-scaler-unity-scaling-with-pixel-format
[322.071225] Starting dynamic subtest: pipe-A
[323.624182] Dynamic subtest pipe-A: SUCCESS (1.555s)
[323.632691] Starting dynamic subtest: pipe-B
[326.189765] Dynamic subtest pipe-B: SUCCESS (2.565s)
[326.201089] Starting dynamic subtest: pipe-C
[327.398578] Dynamic subtest pipe-C: SUCCESS (1.208s)
[327.409803] Starting dynamic subtest: pipe-D
[328.621379] Dynamic subtest pipe-D: SUCCESS (1.222s)
[328.623776] Subtest plane-scaler-unity-scaling-with-pixel-format: SUCCESS (6.552s)
[329.786266] [076/131] (688s left) vgem_basic (create)
[329.827738] Starting subtest: create
[329.829614] Subtest create: SUCCESS (0.000s)
[329.881439] [077/131] (688s left) kms_addfb_basic (addfb25-bad-modifier)
[329.975254] Starting subtest: addfb25-bad-modifier
[329.977588] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[330.093290] [078/131] (688s left) perf_pmu (busy-idle-check-all)
[330.132758] Starting subtest: busy-idle-check-all
[330.135037] Starting dynamic subtest: rcs0
[330.809065] Dynamic subtest rcs0: SUCCESS (0.676s)
[330.821438] Starting dynamic subtest: bcs0
[331.461750] Dynamic subtest bcs0: SUCCESS (0.651s)
[331.473888] Starting dynamic subtest: vcs0
[332.952400] Dynamic subtest vcs0: SUCCESS (1.487s)
[332.963805] Starting dynamic subtest: vcs1
[334.870609] Dynamic subtest vcs1: SUCCESS (1.915s)
[334.882836] Starting dynamic subtest: vecs0
[336.917436] Dynamic subtest vecs0: SUCCESS (2.044s)
[336.929337] Starting dynamic subtest: ccs0
[337.573115] Dynamic subtest ccs0: SUCCESS (0.655s)
[337.575693] Subtest busy-idle-check-all: SUCCESS (7.441s)
[337.702910] [079/131] (680s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-msflip-blt)
[337.808805] Starting subtest: fbcpsr-1p-primscrn-shrfb-msflip-blt
[345.018050] Subtest fbcpsr-1p-primscrn-shrfb-msflip-blt: SUCCESS (7.213s)
[345.175046] [080/131] (673s left) kms_chamelium_edid (dp-mode-timings)
[345.563321] Subtest dp-mode-timings: SKIP (0.000s)
[346.363336] [081/131] (672s left) kms_cursor_legacy (short-flip-before-cursor-toggle)
[346.489843] Starting subtest: short-flip-before-cursor-toggle
[347.420518] Subtest short-flip-before-cursor-toggle: SUCCESS (0.929s)
[348.205579] [082/131] (670s left) gem_exec_balancer (waits)
[348.268837] Starting subtest: waits
[354.806925] Subtest waits: SUCCESS (6.485s)
[355.060936] [083/131] (663s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-sf)
[360.057728] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-sf
[360.062769] Subtest fbc-pr-overlay-plane-move-continuous-exceed-sf: SKIP (0.003s)
[360.908705] [084/131] (657s left) gem_ctx_param (invalid-get-ringsize)
[360.967845] Starting subtest: invalid-get-ringsize
[360.970182] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[361.101975] [085/131] (657s left) gem_ctx_bad_destroy (double-destroy)
[361.150259] Starting subtest: double-destroy
[361.152470] Subtest double-destroy: SUCCESS (0.000s)
[361.221582] [086/131] (657s left) kms_frontbuffer_tracking (fbc-2p-shrfb-fliptrack-mmap-gtt)
[361.316748] Starting subtest: fbc-2p-shrfb-fliptrack-mmap-gtt
[361.320690] Subtest fbc-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[361.420429] [087/131] (657s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-blt)
[361.524644] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-blt
[365.290717] Subtest fbc-1p-primscrn-cur-indfb-draw-blt: SUCCESS (3.770s)
[366.420497] [088/131] (652s left) gem_softpin (evict-single-offset)
[366.484931] Starting subtest: evict-single-offset
[392.853240] Subtest evict-single-offset: SUCCESS (26.365s)
[392.936163] [089/131] (625s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-mc-ccs)
[393.083253] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-mc-ccs
[393.085554] Starting dynamic subtest: pipe-A-eDP-1
[393.144062] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[393.155058] Starting dynamic subtest: pipe-B-eDP-1
[393.213566] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[393.224283] Starting dynamic subtest: pipe-C-eDP-1
[393.281310] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[393.290852] Starting dynamic subtest: pipe-D-eDP-1
[393.349814] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s)
[393.354327] Subtest crc-sprite-planes-basic-y-tiled-gen12-mc-ccs: SKIP (0.008s)
[395.257911] [090/131] (623s left) gem_exec_reloc (basic-scanout)
[395.325831] Subtest basic-scanout: SKIP (0.000s)
[395.409273] [091/131] (623s left) kms_psr2_sf (psr2-overlay-primary-update-sf-dmg-area)
[400.416521] Starting subtest: psr2-overlay-primary-update-sf-dmg-area
[400.418920] Starting dynamic subtest: pipe-A-eDP-1
[406.993056] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.574s)
[407.003182] Starting dynamic subtest: pipe-B-eDP-1
[413.603284] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.608s)
[413.606276] Subtest psr2-overlay-primary-update-sf-dmg-area: SUCCESS (13.186s)
[414.475070] [092/131] (604s left) gem_ctx_sseu (mmap-args)
[414.539446] Subtest mmap-args: SKIP (0.000s)
[414.609541] [093/131] (604s left) syncobj_wait (multi-wait-submitted-signaled)
[414.680495] Starting subtest: multi-wait-submitted-signaled
[414.682940] Subtest multi-wait-submitted-signaled: SUCCESS (0.000s)
[414.754902] [094/131] (604s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-cpu)
[414.850895] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-cpu
[414.855302] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[414.960160] [095/131] (604s left) gem_render_copy (yf-tiled-ccs-to-x-tiled)
[415.020464] Starting subtest: yf-tiled-ccs-to-x-tiled
[415.024799] Subtest yf-tiled-ccs-to-x-tiled: SKIP (0.000s)
[415.207162] [096/131] (603s left) syncobj_wait (single-wait-all-submitted)
[415.263198] Starting subtest: single-wait-all-submitted
[415.369067] Subtest single-wait-all-submitted: SUCCESS (0.105s)
[415.447307] [097/131] (603s left) kms_pm_rpm (universal-planes)
[417.106032] Starting subtest: universal-planes
[417.108136] Starting dynamic subtest: plane-33
[425.452077] Dynamic subtest plane-33: SUCCESS (8.350s)
[425.463996] Starting dynamic subtest: plane-43
[433.744277] Dynamic subtest plane-43: SUCCESS (8.290s)
[433.755458] Starting dynamic subtest: plane-53
[442.006453] Dynamic subtest plane-53: SUCCESS (8.260s)
[442.018054] Starting dynamic subtest: plane-63
[450.389970] Dynamic subtest plane-63: SUCCESS (8.381s)
[450.400239] Starting dynamic subtest: plane-73
[458.746636] Dynamic subtest plane-73: SUCCESS (8.354s)
[458.757072] Starting dynamic subtest: plane-83
[467.435049] Dynamic subtest plane-83: SUCCESS (8.686s)
[467.438489] Subtest universal-planes: SUCCESS (50.334s)
[467.790355] [098/131] (551s left) kms_cursor_edge_walk (128x128-left-edge)
[467.890291] Starting subtest: 128x128-left-edge
[467.892591] Starting dynamic subtest: pipe-A-eDP-1
[471.334679] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.440s)
[471.345646] Starting dynamic subtest: pipe-D-eDP-1
[474.451572] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s)
[474.453866] Subtest 128x128-left-edge: SUCCESS (6.559s)
[475.259544] [099/131] (543s left) kms_psr (pr-sprite-plane-onoff)
[475.357056] Starting subtest: pr-sprite-plane-onoff
[475.361274] Subtest pr-sprite-plane-onoff: SKIP (0.000s)
[475.425490] [100/131] (543s left) drm_read (fault-buffer)
[475.588966] Starting subtest: fault-buffer
[475.591020] Subtest fault-buffer: SUCCESS (0.001s)
[475.729801] [101/131] (543s left) kms_feature_discovery (psr1)
[475.826293] Starting subtest: psr1
[475.828185] Subtest psr1: SUCCESS (0.000s)
[475.902548] [102/131] (543s left) kms_psr (fbc-psr-cursor-blt)
[475.989268] Starting subtest: fbc-psr-cursor-blt
[475.991448] Starting dynamic subtest: eDP-1
[475.995704] Dynamic subtest eDP-1: SKIP (0.000s)
[475.999991] Subtest fbc-psr-cursor-blt: SKIP (0.001s)
[476.059094] [103/131] (543s left) kms_flip (dpms-vs-vblank-race-interruptible)
[476.152986] Starting subtest: dpms-vs-vblank-race-interruptible
[476.155225] Starting dynamic subtest: A-eDP1
[481.099236] Dynamic subtest A-eDP1: SUCCESS (4.944s)
[481.108427] Starting dynamic subtest: B-eDP1
[485.694764] Dynamic subtest B-eDP1: SUCCESS (4.594s)
[485.704276] Starting dynamic subtest: C-eDP1
[490.272133] Dynamic subtest C-eDP1: SUCCESS (4.576s)
[490.282538] Starting dynamic subtest: D-eDP1
[494.757429] Dynamic subtest D-eDP1: SUCCESS (4.485s)
[494.759862] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.607s)
[495.544986] [104/131] (523s left) syncobj_timeline (32bits-limit)
[495.609402] Starting subtest: 32bits-limit
[495.611807] Subtest 32bits-limit: SUCCESS (0.001s)
[495.735519] [105/131] (523s left) kms_flip (2x-flip-vs-modeset)
[495.837490] Starting subtest: 2x-flip-vs-modeset
[495.847842] Subtest 2x-flip-vs-modeset: SKIP (0.010s)
[495.962773] [106/131] (523s left) kms_chamelium_frames (hdmi-crc-multiple)
[496.371628] Subtest hdmi-crc-multiple: SKIP (0.000s)
[497.158365] [107/131] (522s left) gem_ctx_param (set-priority-invalid-size)
[497.221255] Starting subtest: set-priority-invalid-size
[497.223721] Subtest set-priority-invalid-size: SUCCESS (0.000s)
[497.298695] [108/131] (522s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions)
[497.424340] Starting subtest: cursorA-vs-flipA-atomic-transitions
[508.611516] Subtest cursorA-vs-flipA-atomic-transitions: SUCCESS (11.187s)
[509.394906] [109/131] (510s left) core_auth (many-magics)
[509.458858] Starting subtest: many-magics
[510.338412] Subtest many-magics: SUCCESS (0.882s)
[510.505393] [110/131] (509s left) kms_flip (flip-vs-rmfb)
[510.605271] Starting subtest: flip-vs-rmfb
[510.607641] Starting dynamic subtest: A-eDP1
[519.276857] Dynamic subtest A-eDP1: SUCCESS (8.671s)
[519.285696] Starting dynamic subtest: B-eDP1
[528.008417] Dynamic subtest B-eDP1: SUCCESS (8.729s)
[528.021554] Starting dynamic subtest: C-eDP1
[536.713138] Dynamic subtest C-eDP1: SUCCESS (8.705s)
[536.722972] Starting dynamic subtest: D-eDP1
[545.344132] Dynamic subtest D-eDP1: SUCCESS (8.630s)
[545.346162] Subtest flip-vs-rmfb: SUCCESS (34.743s)
[546.517205] [111/131] (473s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[546.624095] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu
[546.628634] Subtest fbc-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[546.739453] [112/131] (472s left) gem_close (basic)
[546.801826] Starting subtest: basic
[546.804219] Subtest basic: SUCCESS (0.000s)
[546.922241] [113/131] (472s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-gtt)
[547.026840] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-gtt
[547.031043] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[547.123779] [114/131] (472s left) kms_big_fb (x-tiled-64bpp-rotate-180)
[547.231790] Starting subtest: x-tiled-64bpp-rotate-180
[549.576271] Subtest x-tiled-64bpp-rotate-180: SUCCESS (2.345s)
[549.800487] [115/131] (470s left) gem_softpin (overlap)
[549.863380] Starting subtest: overlap
[550.806381] Subtest overlap: SUCCESS (0.941s)
[550.959737] [116/131] (468s left) kms_addfb_basic (invalid-get-prop-any)
[551.017602] Starting subtest: invalid-get-prop-any
[551.019753] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[551.156734] [117/131] (468s left) gem_ctx_shared (q-smoketest)
[551.208452] Starting subtest: Q-smoketest
[551.210811] Starting dynamic subtest: rcs0
[556.838915] Dynamic subtest rcs0: SUCCESS (5.518s)
[556.855061] Starting dynamic subtest: bcs0
[562.328642] Dynamic subtest bcs0: SUCCESS (5.500s)
[562.339691] Starting dynamic subtest: vcs0
[567.801956] Dynamic subtest vcs0: SUCCESS (5.471s)
[567.814220] Starting dynamic subtest: vcs1
[573.289278] Dynamic subtest vcs1: SUCCESS (5.487s)
[573.310161] Starting dynamic subtest: vecs0
[578.777112] Dynamic subtest vecs0: SUCCESS (5.485s)
[578.788451] Starting dynamic subtest: ccs0
[584.218292] Dynamic subtest ccs0: SUCCESS (5.497s)
[584.220326] Subtest Q-smoketest: SUCCESS (32.963s)
[584.357223] [118/131] (435s left) syncobj_timeline (signal)
[584.415982] Starting subtest: signal
[584.418334] Subtest signal: SUCCESS (0.000s)
[584.534621] [119/131] (435s left) kms_pm_lpsp (kms-lpsp)
[585.644474] Starting subtest: kms-lpsp
[585.646816] Starting dynamic subtest: pipe-A-eDP-1
[585.801722] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.151s)
[586.094434] Subtest kms-lpsp: SUCCESS (0.449s)
[586.933039] [120/131] (433s left) gem_mmap_gtt (fault-concurrent)
[586.997655] Subtest fault-concurrent: SKIP (0.000s)
[587.065066] [121/131] (432s left) kms_ccs (bad-pixel-format-y-tiled-gen12-mc-ccs)
[587.159135] Starting subtest: bad-pixel-format-y-tiled-gen12-mc-ccs
[587.161383] Starting dynamic subtest: pipe-A-eDP-1
[587.184731] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[587.196159] Starting dynamic subtest: pipe-B-eDP-1
[587.217328] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[587.226868] Starting dynamic subtest: pipe-C-eDP-1
[587.249392] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[587.259913] Starting dynamic subtest: pipe-D-eDP-1
[587.282095] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[587.286756] Subtest bad-pixel-format-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[589.290883] [122/131] (430s left) kms_flip (wf_vblank-ts-check-interruptible)
[589.382737] Starting subtest: wf_vblank-ts-check-interruptible
[589.385179] Starting dynamic subtest: A-eDP1
[598.363605] Dynamic subtest A-eDP1: SUCCESS (8.948s)
[598.375372] Starting dynamic subtest: B-eDP1
[607.287409] Dynamic subtest B-eDP1: SUCCESS (8.923s)
[607.299648] Starting dynamic subtest: C-eDP1
[616.210415] Dynamic subtest C-eDP1: SUCCESS (8.910s)
[616.220666] Starting dynamic subtest: D-eDP1
[625.131760] Dynamic subtest D-eDP1: SUCCESS (8.917s)
[625.134161] Subtest wf_vblank-ts-check-interruptible: SUCCESS (35.708s)
[626.296855] [123/131] (393s left) gem_media_vme
[626.429752] [124/131] (393s left) kms_sequence (queue-idle)
[626.526107] Starting subtest: queue-idle
[626.528472] Starting dynamic subtest: pipe-A-eDP-1
[628.353364] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.825s)
[628.364087] Starting dynamic subtest: pipe-B-eDP-1
[630.866879] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.511s)
[630.877266] Starting dynamic subtest: pipe-C-eDP-1
[633.276408] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.409s)
[633.286150] Starting dynamic subtest: pipe-D-eDP-1
[635.698676] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.421s)
[635.700822] Subtest queue-idle: SUCCESS (9.172s)
[636.499960] [125/131] (383s left) kms_psr (fbc-psr-dpms)
[636.605068] Starting subtest: fbc-psr-dpms
[636.607041] Starting dynamic subtest: eDP-1
[636.611205] Dynamic subtest eDP-1: SKIP (0.000s)
[636.615312] Subtest fbc-psr-dpms: SKIP (0.001s)
[636.676711] [126/131] (383s left) kms_vblank (wait-busy)
[636.763309] Starting subtest: wait-busy
[636.765613] Starting dynamic subtest: pipe-A-eDP-1
[638.651304] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.885s)
[638.667048] Starting dynamic subtest: pipe-D-eDP-1
[641.251562] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.598s)
[641.253980] Subtest wait-busy: SUCCESS (4.487s)
[642.040438] [127/131] (378s left) kms_color (invalid-gamma-lut-sizes)
[642.141184] Starting subtest: invalid-gamma-lut-sizes
[642.143532] Starting dynamic subtest: pipe-A
[642.428847] Dynamic subtest pipe-A: SUCCESS (0.285s)
[642.438338] Starting dynamic subtest: pipe-B
[642.440767] Dynamic subtest pipe-B: SUCCESS (0.001s)
[642.450340] Starting dynamic subtest: pipe-C
[642.452669] Dynamic subtest pipe-C: SUCCESS (0.001s)
[642.461669] Starting dynamic subtest: pipe-D
[642.463862] Dynamic subtest pipe-D: SUCCESS (0.001s)
[642.466162] Subtest invalid-gamma-lut-sizes: SUCCESS (0.290s)
[643.264098] [128/131] (377s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic)
[643.380333] Starting subtest: flip-vs-cursor-busy-crc-atomic
[644.192575] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.813s)
[644.984295] [129/131] (375s left) syncobj_timeline (transfer-timeline-point)
[645.043746] Starting subtest: transfer-timeline-point
[645.045991] Subtest transfer-timeline-point: SUCCESS (0.000s)
[645.133658] [130/131] (375s left) i915_selftest (mock)
[648.710760] Starting subtest: mock
[648.715837] Starting dynamic subtest: sanitycheck
[649.446174] Dynamic subtest sanitycheck: SUCCESS (0.735s)
[649.455680] Starting dynamic subtest: shmem
[650.125746] Dynamic subtest shmem: SUCCESS (0.678s)
[650.135649] Starting dynamic subtest: fence
[658.077559] Dynamic subtest fence: SUCCESS (7.949s)
[658.087821] Starting dynamic subtest: scatterlist
[659.742261] Dynamic subtest scatterlist: SUCCESS (1.663s)
[659.751566] Starting dynamic subtest: syncmap
[662.926658] Dynamic subtest syncmap: SUCCESS (3.182s)
[662.941752] Starting dynamic subtest: uncore
[663.626314] Dynamic subtest uncore: SUCCESS (0.698s)
[663.640709] Starting dynamic subtest: ring
[664.312480] Dynamic subtest ring: SUCCESS (0.685s)
[664.326747] Starting dynamic subtest: engine
[665.039427] Dynamic subtest engine: SUCCESS (0.724s)
[665.049031] Starting dynamic subtest: timelines
[668.878168] Dynamic subtest timelines: SUCCESS (3.837s)
[668.887321] Starting dynamic subtest: requests
[672.413073] Dynamic subtest requests: SUCCESS (3.533s)
[672.423075] Starting dynamic subtest: objects
[673.221084] Dynamic subtest objects: SUCCESS (0.806s)
[673.230940] Starting dynamic subtest: phys
[674.054451] Dynamic subtest phys: SUCCESS (0.831s)
[674.063587] Starting dynamic subtest: dmabuf
[674.827053] Dynamic subtest dmabuf: SUCCESS (0.771s)
[674.836862] Starting dynamic subtest: vma
[680.429373] Dynamic subtest vma: SUCCESS (5.601s)
[680.439119] Starting dynamic subtest: evict
[681.799532] Dynamic subtest evict: SUCCESS (1.368s)
[681.808037] Starting dynamic subtest: gtt
[685.131043] Dynamic subtest gtt: SUCCESS (3.330s)
[685.140786] Starting dynamic subtest: hugepages
[686.034049] Dynamic subtest hugepages: SUCCESS (0.901s)
[686.043093] Starting dynamic subtest: memory_region
[690.242341] Dynamic subtest memory_region: SUCCESS (4.206s)
[690.245058] Subtest mock: SUCCESS (41.532s)
[690.272787] [FACT i915_selftest (mock)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[690.273453] [FACT i915_selftest (mock)] deleted: kernel.kmod_is_loaded.i915: true
[690.276565] [131/131] (330s left) api_intel_bb (reset-bb)
[691.725277] Starting subtest: reset-bb
[691.736715] Subtest reset-bb: SUCCESS (0.012s)
[691.848885] [FACT api_intel_bb (reset-bb)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[691.850252] [FACT api_intel_bb (reset-bb)] new: kernel.kmod_is_loaded.i915: true
[691.850880] Closing watchdogs
results: parsing output: 0/ for test: kms_async_flips
results: parsing output: 1/ for test: gem_exec_params
results: parsing output: 2/ for test: kms_chamelium_audio
results: parsing output: 3/ for test: kms_atomic_transition
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_schedule
results: parsing output: 6/ for test: prime_mmap
results: parsing output: 7/ for test: gem_tiling_max_stride
results: parsing output: 8/ for test: gem_exec_whisper
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_big_fb
results: parsing output: 11/ for test: syncobj_timeline
results: parsing output: 12/ for test: gen7_exec_parse
results: parsing output: 13/ for test: kms_big_fb
results: parsing output: 14/ for test: sw_sync
results: parsing output: 15/ for test: kms_frontbuffer_tracking
results: parsing output: 16/ for test: gem_exec_reloc
results: parsing output: 17/ for test: syncobj_timeline
results: parsing output: 18/ for test: gem_userptr_blits
results: parsing output: 19/ for test: kms_content_protection
results: parsing output: 20/ for test: kms_cursor_crc
results: parsing output: 21/ for test: kms_big_fb
results: parsing output: 22/ for test: gem_eio
results: parsing output: 23/ for test: i915_fb_tiling
results: parsing output: 24/ for test: kms_busy
results: parsing output: 25/ for test: kms_plane_cursor
results: parsing output: 26/ for test: api_intel_bb
results: parsing output: 27/ for test: gem_spin_batch
results: parsing output: 28/ for test: kms_rotation_crc
results: parsing output: 29/ for test: kms_psr
results: parsing output: 30/ for test: gem_ctx_isolation
results: parsing output: 31/ for test: kms_dirtyfb
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: kms_mmap_write_crc
results: parsing output: 35/ for test: i915_pm_rc6_residency
results: parsing output: 36/ for test: kms_big_fb
results: parsing output: 37/ for test: sysfs_heartbeat_interval
results: parsing output: 38/ for test: dumb_buffer
results: parsing output: 39/ for test: gem_mmap_wc
results: parsing output: 40/ for test: kms_atomic_interruptible
results: parsing output: 41/ for test: kms_frontbuffer_tracking
results: parsing output: 42/ for test: gem_close_race
results: parsing output: 43/ for test: gen9_exec_parse
results: parsing output: 44/ for test: kms_ccs
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_selftest
results: parsing output: 47/ for test: prime_self_import
results: parsing output: 48/ for test: kms_plane_scaling
results: parsing output: 49/ for test: gem_exec_schedule
results: parsing output: 50/ for test: kms_frontbuffer_tracking
results: parsing output: 51/ for test: gem_pxp
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: prime_busy
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_frontbuffer_tracking
results: parsing output: 56/ for test: kms_properties
results: parsing output: 57/ for test: gem_exec_fence
results: parsing output: 58/ for test: kms_frontbuffer_tracking
results: parsing output: 59/ for test: kms_joiner
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: kms_flip_scaled_crc
results: parsing output: 62/ for test: gem_exec_fence
results: parsing output: 63/ for test: gem_mmap_gtt
results: parsing output: 64/ for test: gem_workarounds
results: parsing output: 65/ for test: kms_cursor_legacy
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: kms_ccs
results: parsing output: 68/ for test: i915_pm_rps
results: parsing output: 69/ for test: kms_frontbuffer_tracking
results: parsing output: 70/ for test: kms_invalid_mode
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: kms_cursor_crc
results: parsing output: 73/ for test: perf_pmu
results: parsing output: 74/ for test: kms_plane_scaling
results: parsing output: 75/ for test: vgem_basic
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: perf_pmu
results: parsing output: 78/ for test: kms_frontbuffer_tracking
results: parsing output: 79/ for test: kms_chamelium_edid
results: parsing output: 80/ for test: kms_cursor_legacy
results: parsing output: 81/ for test: gem_exec_balancer
results: parsing output: 82/ for test: kms_psr2_sf
results: parsing output: 83/ for test: gem_ctx_param
results: parsing output: 84/ for test: gem_ctx_bad_destroy
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_frontbuffer_tracking
results: parsing output: 87/ for test: gem_softpin
results: parsing output: 88/ for test: kms_ccs
results: parsing output: 89/ for test: gem_exec_reloc
results: parsing output: 90/ for test: kms_psr2_sf
results: parsing output: 91/ for test: gem_ctx_sseu
results: parsing output: 92/ for test: syncobj_wait
results: parsing output: 93/ for test: kms_frontbuffer_tracking
results: parsing output: 94/ for test: gem_render_copy
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_pm_rpm
results: parsing output: 97/ for test: kms_cursor_edge_walk
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: drm_read
results: parsing output: 100/ for test: kms_feature_discovery
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: syncobj_timeline
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_chamelium_frames
results: parsing output: 106/ for test: gem_ctx_param
results: parsing output: 107/ for test: kms_cursor_legacy
results: parsing output: 108/ for test: core_auth
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: gem_close
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_big_fb
results: parsing output: 114/ for test: gem_softpin
results: parsing output: 115/ for test: kms_addfb_basic
results: parsing output: 116/ for test: gem_ctx_shared
results: parsing output: 117/ for test: syncobj_timeline
results: parsing output: 118/ for test: kms_pm_lpsp
results: parsing output: 119/ for test: gem_mmap_gtt
results: parsing output: 120/ for test: kms_ccs
results: parsing output: 121/ for test: kms_flip
results: parsing output: 122/ for test: gem_media_vme
results: parsing output: 123/ for test: kms_sequence
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_vblank
results: parsing output: 126/ for test: kms_color
results: parsing output: 127/ for test: kms_cursor_legacy
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: i915_selftest
results: parsing output: 130/ for test: api_intel_bb
Done.