[56.400182] Initializing watchdogs
[56.400241]   /dev/watchdog0
[56.414974] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:9a49 Intel Tigerlake (Gen12) TigerLake-LP GT2 [Iris Xe Graphics]
[56.419675] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.422567] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.424468] [001/130] (960s left) gem_exec_schedule (semaphore-user)
[56.550237] Starting subtest: semaphore-user
[56.557455] Subtest semaphore-user: SUCCESS (0.007s)
[56.851348] [002/130] (960s left) kms_psr2_sf (fbc-psr2-primary-plane-update-sf-dmg-area)
[56.944856] Subtest fbc-psr2-primary-plane-update-sf-dmg-area: SKIP (0.000s)
[56.979956] [003/130] (960s left) kms_plane (plane-panning-top-left)
[57.067710] Starting subtest: plane-panning-top-left
[57.068452] Starting dynamic subtest: pipe-A
[57.471604] Dynamic subtest pipe-A: SUCCESS (0.403s)
[57.477122] Starting dynamic subtest: pipe-B
[57.804562] Dynamic subtest pipe-B: SUCCESS (0.332s)
[57.805337] Subtest plane-panning-top-left: SUCCESS (0.737s)
[57.938470] [004/130] (959s left) kms_legacy_colorkey (invalid-plane)
[58.028513] Starting subtest: invalid-plane
[58.029249] Starting dynamic subtest: zero-id
[58.029967] Dynamic subtest zero-id: SUCCESS (0.000s)
[58.034584] Starting dynamic subtest: outrange-id
[58.035287] Dynamic subtest outrange-id: SUCCESS (0.000s)
[58.035985] Subtest invalid-plane: SUCCESS (0.000s)
[58.079352] [005/130] (958s left) gem_mmap_gtt (basic-short)
[58.115776] Starting subtest: basic-short
[58.144323] Subtest basic-short: SUCCESS (0.029s)
[58.214490] [006/130] (958s left) syncobj_timeline (wait-all-for-submit-snapshot)
[58.252047] Starting subtest: wait-all-for-submit-snapshot
[58.334943] Subtest wait-all-for-submit-snapshot: SUCCESS (0.082s)
[58.399148] [007/130] (958s left) prime_vgem (basic-fence-read)
[58.491527] Starting subtest: basic-fence-read
[58.532099] Subtest basic-fence-read: SUCCESS (0.041s)
[58.652808] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true
[58.654339] [008/130] (958s left) gem_exec_params (no-vebox)
[58.694049] Starting subtest: no-vebox
[58.694854] Subtest no-vebox: SUCCESS (0.001s)
[58.809656] [009/130] (958s left) perf (low-oa-exponent-permissions)
[58.890345] Starting subtest: low-oa-exponent-permissions
[58.940693] Subtest low-oa-exponent-permissions: SUCCESS (0.051s)
[58.985371] [010/130] (958s left) gem_exercise_blt (fast-copy)
[59.024584] Starting subtest: fast-copy
[59.025372] Starting dynamic subtest: linear-smem-smem
[59.046022] Dynamic subtest linear-smem-smem: SUCCESS (0.022s)
[59.051177] Starting dynamic subtest: ymajor-smem-smem
[59.064548] Dynamic subtest ymajor-smem-smem: SUCCESS (0.018s)
[59.070058] Starting dynamic subtest: tile4-smem-smem
[59.083053] Dynamic subtest tile4-smem-smem: SUCCESS (0.018s)
[59.087769] Starting dynamic subtest: tile64-smem-smem
[59.101868] Dynamic subtest tile64-smem-smem: SUCCESS (0.019s)
[59.102574] Subtest fast-copy: SUCCESS (0.078s)
[59.218919] [011/130] (958s left) gem_create (busy-create)
[59.260931] Starting subtest: busy-create
[59.261643] Starting dynamic subtest: smem0
[91.522617] Dynamic subtest smem0: SUCCESS (32.261s)
[91.523702] Subtest busy-create: SUCCESS (32.262s)
[91.695221] [012/130] (925s left) api_intel_bb (intel-bb-blit-x)
[91.731308] Starting subtest: intel-bb-blit-x
[94.927049] Subtest intel-bb-blit-x: SUCCESS (3.161s)
[94.995863] [013/130] (922s left) kms_big_fb (4-tiled-32bpp-rotate-270)
[95.095417] Starting subtest: 4-tiled-32bpp-rotate-270
[95.096796] Subtest 4-tiled-32bpp-rotate-270: SKIP (0.000s)
[95.177536] [014/130] (922s left) gem_exec_flush (basic-batch-kernel-default-wb)
[95.225093] Starting subtest: basic-batch-kernel-default-wb
[100.749108] Subtest basic-batch-kernel-default-wb: SUCCESS (5.524s)
[100.945522] [015/130] (916s left) perf_pmu (busy-no-semaphores)
[100.985297] Starting subtest: busy-no-semaphores
[100.986031] Starting dynamic subtest: rcs0
[101.536106] Dynamic subtest rcs0: SUCCESS (0.542s)
[101.548371] Starting dynamic subtest: bcs0
[102.060041] Dynamic subtest bcs0: SUCCESS (0.523s)
[102.068273] Starting dynamic subtest: vcs0
[102.597896] Dynamic subtest vcs0: SUCCESS (0.538s)
[102.606360] Starting dynamic subtest: vcs1
[103.127690] Dynamic subtest vcs1: SUCCESS (0.529s)
[103.136113] Starting dynamic subtest: vecs0
[103.665782] Dynamic subtest vecs0: SUCCESS (0.538s)
[103.666613] Subtest busy-no-semaphores: SUCCESS (2.672s)
[103.744763] [016/130] (913s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi
[103.782687] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted
[103.898817] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.106s)
[103.953280] [017/130] (913s left) kms_pm_rpm (modeset-lpsp)
[105.376902] Starting subtest: modeset-lpsp
[106.662054] Subtest modeset-lpsp: SUCCESS (1.287s)
[106.765936] [018/130] (910s left) kms_flip (2x-flip-vs-dpms)
[106.856160] Starting subtest: 2x-flip-vs-dpms
[106.864580] Subtest 2x-flip-vs-dpms: SKIP (0.009s)
[106.926646] [019/130] (910s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt)
[107.020409] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt
[107.021761] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s)
[107.128545] [020/130] (910s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[107.216791] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[107.217555] Starting dynamic subtest: pipe-A-valid-mode
[108.363759] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.146s)
[108.364552] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (1.147s)
[108.505573] [021/130] (909s left) kms_content_protection (dp-mst-lic-type-0)
[108.614546] Starting subtest: dp-mst-lic-type-0
[108.615931] Subtest dp-mst-lic-type-0: SKIP (0.000s)
[108.707647] [022/130] (908s left) kms_ccs (crc-primary-basic-4-tiled-lnl-ccs)
[108.796543] Starting subtest: crc-primary-basic-4-tiled-lnl-ccs
[108.797945] Subtest crc-primary-basic-4-tiled-lnl-ccs: SKIP (0.000s)
[108.942835] [023/130] (908s left) kms_getfb (getfb-handle-zero)
[108.981280] Starting subtest: getfb-handle-zero
[108.982009] Subtest getfb-handle-zero: SUCCESS (0.000s)
[109.085803] [024/130] (908s left) gem_render_copy (yf-tiled-mc-ccs-to-vebox-y-tiled)
[109.132741] Starting subtest: yf-tiled-mc-ccs-to-vebox-y-tiled
[109.133548] Starting dynamic subtest: smem
[109.236934] Dynamic subtest smem: SUCCESS (0.103s)
[109.237685] Subtest yf-tiled-mc-ccs-to-vebox-y-tiled: SUCCESS (0.104s)
[109.420275] [025/130] (908s left) gem_ctx_create (basic-files)
[109.465578] Starting subtest: basic-files
[111.477827] Subtest basic-files: SUCCESS (2.012s)
[111.663316] [026/130] (906s left) gem_exec_create (forked)
[111.708993] Starting subtest: forked
[111.709983] Starting dynamic subtest: smem
[131.806208] Dynamic subtest smem: SUCCESS (20.097s)
[131.806936] Subtest forked: SUCCESS (20.097s)
[131.993504] [027/130] (885s left) i915_hangman (detector)
[132.037040] Starting subtest: detector
[132.037807] Starting dynamic subtest: rcs0
[142.089326] Dynamic subtest rcs0: SUCCESS (10.052s)
[142.103568] Starting dynamic subtest: bcs0
[152.049135] Dynamic subtest bcs0: SUCCESS (9.959s)
[152.063053] Starting dynamic subtest: vcs0
[161.056961] Dynamic subtest vcs0: SUCCESS (9.007s)
[161.069751] Starting dynamic subtest: vcs1
[171.068963] Dynamic subtest vcs1: SUCCESS (10.011s)
[171.083056] Starting dynamic subtest: vecs0
[181.024226] Dynamic subtest vecs0: SUCCESS (9.954s)
[181.025461] Subtest detector: SUCCESS (48.987s)
[181.094912] [028/130] (836s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[181.196826] Starting subtest: extended-modeset-hang-newfb-with-reset
[181.198329] Starting dynamic subtest: pipe-A
[184.044958] Dynamic subtest pipe-A: SUCCESS (2.847s)
[184.055899] Starting dynamic subtest: pipe-D
[186.915736] Dynamic subtest pipe-D: SUCCESS (2.865s)
[186.916427] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (5.720s)
[187.073648] [029/130] (830s left) gem_ctx_persistence (hang)
[187.115509] Starting subtest: hang
[187.117062] Subtest hang: SUCCESS (0.001s)
[187.178956] [030/130] (830s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[187.273822] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[187.275240] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[187.368424] [031/130] (830s left) kms_big_fb (linear-16bpp-rotate-180)
[187.463259] Starting subtest: linear-16bpp-rotate-180
[189.124381] Subtest linear-16bpp-rotate-180: SUCCESS (1.661s)
[189.299228] [032/130] (828s left) perf_pmu (idle-no-semaphores)
[189.339426] Starting subtest: idle-no-semaphores
[189.340166] Starting dynamic subtest: rcs0
[189.872785] Dynamic subtest rcs0: SUCCESS (0.524s)
[189.882225] Starting dynamic subtest: bcs0
[190.392220] Dynamic subtest bcs0: SUCCESS (0.519s)
[190.401600] Starting dynamic subtest: vcs0
[190.917913] Dynamic subtest vcs0: SUCCESS (0.525s)
[190.927139] Starting dynamic subtest: vcs1
[191.438323] Dynamic subtest vcs1: SUCCESS (0.519s)
[191.447378] Starting dynamic subtest: vecs0
[191.962731] Dynamic subtest vecs0: SUCCESS (0.524s)
[191.963871] Subtest idle-no-semaphores: SUCCESS (2.614s)
[192.024231] [033/130] (826s left) perf (disabled-read-error)
[192.092708] Starting subtest: disabled-read-error
[192.121796] Subtest disabled-read-error: SUCCESS (0.029s)
[192.154211] [034/130] (825s left) gem_mmap_gtt (basic-small-copy)
[192.190390] Starting subtest: basic-small-copy
[194.050541] Subtest basic-small-copy: SUCCESS (1.860s)
[194.115107] [035/130] (824s left) kms_writeback (writeback-invalid-parameters)
[194.255599] Subtest writeback-invalid-parameters: SKIP (0.000s)
[194.292312] [036/130] (823s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[194.336803] Starting subtest: multi-wait-for-submit-available-submitted
[194.337565] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[194.392053] [037/130] (823s left) gem_media_vme
[194.478725] [038/130] (823s left) perf (mi-rpc)
[194.563423] Starting subtest: mi-rpc
[194.564858] Subtest mi-rpc: SKIP (0.000s)
[194.598000] [039/130] (823s left) kms_big_fb (linear-32bpp-rotate-90)
[194.694948] Starting subtest: linear-32bpp-rotate-90
[194.779395] Subtest linear-32bpp-rotate-90: SKIP (0.083s)
[194.886686] [040/130] (823s left) kms_big_fb (yf-tiled-32bpp-rotate-90)
[194.981048] Starting subtest: yf-tiled-32bpp-rotate-90
[194.982439] Subtest yf-tiled-32bpp-rotate-90: SKIP (0.000s)
[195.078136] [041/130] (823s left) kms_ccs (crc-primary-basic-y-tiled-gen12-rc-ccs-cc)
[195.166664] Starting subtest: crc-primary-basic-y-tiled-gen12-rc-ccs-cc
[195.167372] Starting dynamic subtest: pipe-A-HDMI-A-1
[196.087636] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.917s)
[196.097478] Starting dynamic subtest: pipe-B-HDMI-A-1
[196.507281] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.416s)
[196.520753] Starting dynamic subtest: pipe-C-HDMI-A-1
[196.933781] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.423s)
[196.947887] Starting dynamic subtest: pipe-D-HDMI-A-1
[197.344644] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.408s)
[197.345683] Subtest crc-primary-basic-y-tiled-gen12-rc-ccs-cc: SUCCESS (2.175s)
[197.537565] [042/130] (820s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-pwrite)
[197.632709] Starting subtest: fbcpsr-rgb101010-draw-pwrite
[197.634082] Subtest fbcpsr-rgb101010-draw-pwrite: SKIP (0.000s)
[197.705466] [043/130] (820s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180)
[197.799466] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180
[198.400881] Subtest x-tiled-max-hw-stride-64bpp-rotate-180: SUCCESS (0.601s)
[198.543673] [044/130] (819s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc)
[198.631893] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc
[198.632643] Starting dynamic subtest: pipe-A-HDMI-A-1
[198.650613] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.002s)
[198.658316] Starting dynamic subtest: pipe-B-HDMI-A-1
[198.676245] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.002s)
[198.682418] Starting dynamic subtest: pipe-C-HDMI-A-1
[198.700948] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.002s)
[198.709168] Starting dynamic subtest: pipe-D-HDMI-A-1
[198.727203] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.002s)
[198.728709] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.011s)
[198.849531] [045/130] (819s left) syncobj_eventfd (binary-wait)
[198.888380] Starting subtest: binary-wait
[198.898252] Subtest binary-wait: SUCCESS (0.010s)
[198.971110] [046/130] (819s left) kms_frontbuffer_tracking (psr-1p-offscren-pri-indfb-draw-pwrite)
[199.063716] Starting subtest: psr-1p-offscren-pri-indfb-draw-pwrite
[199.065190] Subtest psr-1p-offscren-pri-indfb-draw-pwrite: SKIP (0.000s)
[199.147956] [047/130] (819s left) drm_fdinfo (virtual-busy)
[199.186411] Starting subtest: virtual-busy
[201.903061] Subtest virtual-busy: SUCCESS (2.716s)
[201.966265] [048/130] (816s left) kms_psr (psr2-sprite-mmap-cpu)
[202.058500] Subtest psr2-sprite-mmap-cpu: SKIP (0.000s)
[202.100638] [049/130] (816s left) kms_psr2_sf (pr-overlay-primary-update-sf-dmg-area)
[202.193060] Subtest pr-overlay-primary-update-sf-dmg-area: SKIP (0.000s)
[202.226657] [050/130] (816s left) sysfs_preempt_timeout (timeout)
[202.266455] Starting subtest: timeout
[202.267199] Starting dynamic subtest: vecs0
[203.185825] Dynamic subtest vecs0: SUCCESS (0.918s)
[203.194945] Starting dynamic subtest: vcs0
[204.137926] Dynamic subtest vcs0: SUCCESS (0.950s)
[204.148139] Starting dynamic subtest: bcs0
[205.095026] Dynamic subtest bcs0: SUCCESS (0.956s)
[205.104512] Starting dynamic subtest: rcs0
[206.068986] Dynamic subtest rcs0: SUCCESS (0.972s)
[206.078496] Starting dynamic subtest: vcs1
[207.001592] Dynamic subtest vcs1: SUCCESS (0.932s)
[207.002675] Subtest timeout: SUCCESS (4.735s)
[207.066430] [051/130] (811s left) kms_psr (psr2-sprite-plane-onoff)
[207.156895] Subtest psr2-sprite-plane-onoff: SKIP (0.000s)
[207.198838] [052/130] (811s left) kms_dsc (dsc-with-output-formats-with-bpc)
[207.287912] Starting subtest: dsc-with-output-formats-with-bpc
[207.305345] Subtest dsc-with-output-formats-with-bpc: SKIP (0.002s)
[207.341591] [053/130] (811s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted)
[207.377994] Starting subtest: invalid-multi-wait-all-unsubmitted
[207.378874] Subtest invalid-multi-wait-all-unsubmitted: SUCCESS (0.000s)
[207.436403] [054/130] (811s left) gem_exec_reloc (basic-gtt)
[207.476176] Starting subtest: basic-gtt
[207.484393] Subtest basic-gtt: SUCCESS (0.008s)
[207.591366] [055/130] (811s left) drm_fdinfo (basics)
[207.628979] Starting subtest: basics
[207.629790] Subtest basics: SUCCESS (0.000s)
[207.687319] [056/130] (811s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move)
[207.784190] Starting subtest: psr-2p-primscrn-spr-indfb-move
[207.785694] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[207.872663] [057/130] (811s left) i915_query (query-topology-coherent-slice-mask)
[207.909862] Starting subtest: query-topology-coherent-slice-mask
[207.910663] Subtest query-topology-coherent-slice-mask: SUCCESS (0.000s)
[207.976480] [058/130] (810s left) kms_sequence (get-idle)
[208.070527] Starting subtest: get-idle
[208.071473] Starting dynamic subtest: pipe-A-HDMI-A-1
[209.273937] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.202s)
[209.281018] Starting dynamic subtest: pipe-B-HDMI-A-1
[210.446835] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.172s)
[210.454146] Starting dynamic subtest: pipe-C-HDMI-A-1
[211.616868] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.169s)
[211.624157] Starting dynamic subtest: pipe-D-HDMI-A-1
[212.792690] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.175s)
[212.793380] Subtest get-idle: SUCCESS (4.723s)
[212.901071] [059/130] (806s left) gem_exec_balancer (semaphore)
[212.951617] Starting subtest: semaphore
[214.011813] Subtest semaphore: SUCCESS (1.060s)
[214.192492] [060/130] (804s left) gem_mmap_offset (pf-nonblock)
[214.229795] Starting subtest: pf-nonblock
[214.233743] Subtest pf-nonblock: SUCCESS (0.005s)
[214.343957] [061/130] (804s left) kms_flip (dpms-off-confusion)
[214.434729] Starting subtest: dpms-off-confusion
[214.436520] Starting dynamic subtest: A-HDMI-A1
[222.123593] Dynamic subtest A-HDMI-A1: SUCCESS (7.666s)
[222.129770] Starting dynamic subtest: B-HDMI-A1
[229.767682] Dynamic subtest B-HDMI-A1: SUCCESS (7.659s)
[229.779286] Starting dynamic subtest: C-HDMI-A1
[237.437651] Dynamic subtest C-HDMI-A1: SUCCESS (7.669s)
[237.446606] Starting dynamic subtest: D-HDMI-A1
[245.136311] Dynamic subtest D-HDMI-A1: SUCCESS (7.672s)
[245.137385] Subtest dpms-off-confusion: SUCCESS (30.675s)
[245.307971] [062/130] (773s left) gem_flink_race (flink_close)
[245.346321] Starting subtest: flink_close
[250.388412] Subtest flink_close: SUCCESS (5.042s)
[250.488607] [063/130] (768s left) kms_frontbuffer_tracking (psr-modesetfrombusy)
[250.587392] Starting subtest: psr-modesetfrombusy
[250.588822] Subtest psr-modesetfrombusy: SKIP (0.000s)
[250.675348] [064/130] (768s left) gem_exec_fence (invalid-fence-array)
[251.023305] Starting subtest: invalid-fence-array
[251.025400] Subtest invalid-fence-array: SUCCESS (0.002s)
[251.371229] [065/130] (767s left) kms_ccs (bad-aux-stride-y-tiled-gen12-mc-ccs)
[251.461882] Starting subtest: bad-aux-stride-y-tiled-gen12-mc-ccs
[251.462640] Starting dynamic subtest: pipe-A-HDMI-A-1
[251.469754] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[251.476203] Starting dynamic subtest: pipe-B-HDMI-A-1
[251.483368] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[251.489741] Starting dynamic subtest: pipe-C-HDMI-A-1
[251.496487] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[251.502651] Starting dynamic subtest: pipe-D-HDMI-A-1
[251.509461] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[251.510816] Subtest bad-aux-stride-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[251.706549] [066/130] (767s left) kms_pipe_crc_basic (read-crc)
[251.798950] Starting subtest: read-crc
[251.800730] Starting dynamic subtest: pipe-A-HDMI-A-1
[252.129755] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.329s)
[252.137122] Starting dynamic subtest: pipe-B-HDMI-A-1
[252.410277] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.278s)
[252.419821] Starting dynamic subtest: pipe-C-HDMI-A-1
[252.712043] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.300s)
[252.719362] Starting dynamic subtest: pipe-D-HDMI-A-1
[253.002916] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.289s)
[253.003616] Subtest read-crc: SUCCESS (1.204s)
[253.119566] [067/130] (766s left) kms_chamelium_hpd (vga-hpd-fast)
[253.269029] Subtest vga-hpd-fast: SKIP (0.000s)
[253.359552] [068/130] (765s left) gem_lmem_swapping (random-engines)
[253.403127] Subtest random-engines: SKIP (0.000s)
[253.441754] [069/130] (765s left) core_getclient
[253.531228] [070/130] (765s left) gem_render_copy (y-tiled-mc-ccs-to-vebox-yf-tiled)
[253.576216] Starting subtest: y-tiled-mc-ccs-to-vebox-yf-tiled
[253.576971] Starting dynamic subtest: smem
[253.657052] Dynamic subtest smem: SUCCESS (0.080s)
[253.657842] Subtest y-tiled-mc-ccs-to-vebox-yf-tiled: SUCCESS (0.081s)
[253.837425] [071/130] (765s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-msflip-blt)
[253.929566] Starting subtest: fbc-1p-primscrn-indfb-msflip-blt
[255.264238] Subtest fbc-1p-primscrn-indfb-msflip-blt: SUCCESS (1.334s)
[255.390893] [072/130] (764s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-upscaling)
[255.482334] Starting subtest: flip-32bpp-linear-to-64bpp-linear-upscaling
[255.483095] Starting dynamic subtest: pipe-A-valid-mode
[256.536876] Dynamic subtest pipe-A-valid-mode: SUCCESS (1.053s)
[256.537772] Subtest flip-32bpp-linear-to-64bpp-linear-upscaling: SUCCESS (1.055s)
[256.682338] [073/130] (762s left) gem_create (create-ext-placement-each)
[256.846393] Starting subtest: create-ext-placement-each
[256.847479] Subtest create-ext-placement-each: SUCCESS (0.000s)
[256.937508] [074/130] (762s left) gem_mmap_wc (write-wc-read-gtt)
[256.975396] Starting subtest: write-wc-read-gtt
[257.304163] Subtest write-wc-read-gtt: SUCCESS (0.321s)
[257.381293] [075/130] (762s left) kms_chamelium_audio (dp-audio)
[257.533132] Subtest dp-audio: SKIP (0.000s)
[257.614296] [076/130] (762s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[257.709779] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[257.711312] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[257.803720] [077/130] (761s left) kms_force_connector_basic (force-connector-state)
[257.938027] Starting subtest: force-connector-state
[258.323025] Subtest force-connector-state: SUCCESS (0.385s)
[258.740600] [078/130] (760s left) kms_big_fb (y-tiled-8bpp-rotate-90)
[258.837670] Starting subtest: y-tiled-8bpp-rotate-90
[258.910081] Subtest y-tiled-8bpp-rotate-90: SKIP (0.071s)
[259.027523] [079/130] (760s left) kms_pm_rpm (system-suspend-modeset)
[260.434159] Starting subtest: system-suspend-modeset
[280.205095] Subtest system-suspend-modeset: SUCCESS (4.880s)
[286.469564] [080/130] (754s left) kms_cursor_legacy (2x-nonblocking-modeset-vs-cursor-atomic)
[286.575316] Starting subtest: 2x-nonblocking-modeset-vs-cursor-atomic
[286.578004] Subtest 2x-nonblocking-modeset-vs-cursor-atomic: SKIP (0.002s)
[286.640978] [081/130] (754s left) kms_getfb (getfb-addfb-different-handles)
[286.678525] Starting subtest: getfb-addfb-different-handles
[286.679251] Subtest getfb-addfb-different-handles: SUCCESS (0.000s)
[286.785627] [082/130] (754s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[286.879353] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[286.880774] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[286.975275] [083/130] (753s left) i915_suspend (fence-restore-tiled2untiled)
[287.013845] Starting subtest: fence-restore-tiled2untiled
[306.820371] Subtest fence-restore-tiled2untiled: SUCCESS (5.196s)
[310.967038] [084/130] (748s left) kms_pm_backlight (bad-brightness)
[311.066289] Subtest bad-brightness: SKIP (0.000s)
[311.105225] [085/130] (748s left) kms_plane_scaling (planes-downscale-factor-0-25-unity-scaling)
[311.194441] Starting subtest: planes-downscale-factor-0-25-unity-scaling
[311.195287] Starting dynamic subtest: pipe-A
[312.685242] Dynamic subtest pipe-A: SKIP (1.490s)
[312.694680] Starting dynamic subtest: pipe-B
[314.968126] Dynamic subtest pipe-B: SKIP (2.283s)
[314.975457] Starting dynamic subtest: pipe-C
[317.275022] Dynamic subtest pipe-C: SKIP (2.308s)
[317.282858] Starting dynamic subtest: pipe-D
[319.573066] Dynamic subtest pipe-D: SKIP (2.297s)
[319.574750] Subtest planes-downscale-factor-0-25-unity-scaling: SKIP (8.380s)
[319.649754] [086/130] (739s left) kms_vblank (ts-continuation-dpms-suspend)
[319.764581] Starting subtest: ts-continuation-dpms-suspend
[319.765275] Starting dynamic subtest: pipe-A-HDMI-A-1
[335.950131] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.357s)
[335.962768] Starting dynamic subtest: pipe-D-HDMI-A-1
[351.952160] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.338s)
[351.953010] Subtest ts-continuation-dpms-suspend: SUCCESS (2.700s)
[361.165433] [087/130] (737s left) i915_pciid
[361.279330] [088/130] (736s left) gem_exec_schedule (preempt-user)
[361.332558] Starting subtest: preempt-user
[361.333326] Starting dynamic subtest: rcs0
[361.350119] Dynamic subtest rcs0: SUCCESS (0.017s)
[361.358793] Starting dynamic subtest: bcs0
[361.365808] Dynamic subtest bcs0: SUCCESS (0.015s)
[361.374547] Starting dynamic subtest: vcs0
[361.382210] Dynamic subtest vcs0: SUCCESS (0.016s)
[361.393244] Starting dynamic subtest: vcs1
[361.402347] Dynamic subtest vcs1: SUCCESS (0.019s)
[361.412264] Starting dynamic subtest: vecs0
[361.422530] Dynamic subtest vecs0: SUCCESS (0.019s)
[361.423373] Subtest preempt-user: SUCCESS (0.090s)
[361.723188] [089/130] (736s left) kms_chamelium_hpd (dp-hpd)
[361.866692] Subtest dp-hpd: SKIP (0.000s)
[361.954654] [090/130] (736s left) syncobj_basic (bad-destroy)
[362.002080] Starting subtest: bad-destroy
[362.002855] Subtest bad-destroy: SUCCESS (0.000s)
[362.061181] [091/130] (736s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[362.149300] Starting subtest: flip-vs-cursor-legacy
[368.048446] Subtest flip-vs-cursor-legacy: SUCCESS (5.865s)
[368.136852] [092/130] (730s left) kms_psr (fbc-psr2-suspend)
[368.233203] Subtest fbc-psr2-suspend: SKIP (0.000s)
[368.271056] [093/130] (730s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-pwrite)
[368.362159] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-pwrite
[368.363540] Subtest fbc-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[368.462409] [094/130] (729s left) perf_pmu (rc6)
[368.502106] Starting subtest: rc6
[368.502916] Starting dynamic subtest: gt0
[374.874735] Dynamic subtest gt0: SUCCESS (6.336s)
[374.882786] Starting dynamic subtest: runtime-pm-gt0
[382.340497] Dynamic subtest runtime-pm-gt0: SUCCESS (7.486s)
[382.353187] Starting dynamic subtest: runtime-pm-long-gt0
[394.782331] Dynamic subtest runtime-pm-long-gt0: SUCCESS (12.437s)
[394.789824] Starting dynamic subtest: other-idle-gt0
[394.791326] Dynamic subtest other-idle-gt0: SKIP (0.000s)
[394.792058] Subtest rc6: SUCCESS (26.266s)
[395.132545] [095/130] (703s left) debugfs_test (read_all_entries_display_on)
[395.230566] Starting subtest: read_all_entries_display_on
[395.421420] Subtest read_all_entries_display_on: SUCCESS (0.191s)
[395.531111] [096/130] (703s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-blt)
[395.627863] Starting subtest: psr-1p-primscrn-spr-indfb-draw-blt
[395.629253] Subtest psr-1p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[395.701964] [097/130] (702s left) kms_cursor_edge_walk (64x64-top-bottom)
[395.793302] Starting subtest: 64x64-top-bottom
[395.794996] Starting dynamic subtest: pipe-A-HDMI-A-1
[397.547133] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.751s)
[397.555558] Starting dynamic subtest: pipe-D-HDMI-A-1
[399.226249] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.677s)
[399.226936] Subtest 64x64-top-bottom: SUCCESS (3.433s)
[399.310564] [098/130] (699s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[399.410815] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[399.412266] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[399.474811] [099/130] (699s left) gem_ctx_shared (single-timeline)
[399.523009] Starting subtest: single-timeline
[399.528863] Subtest single-timeline: SUCCESS (0.004s)
[399.699886] [100/130] (698s left) api_intel_allocator (fork-simple-stress)
[399.737646] Starting subtest: fork-simple-stress
[405.191360] Subtest fork-simple-stress: SUCCESS (5.420s)
[405.250365] [101/130] (693s left) kms_cursor_crc (cursor-random-32x10)
[405.350204] Starting subtest: cursor-random-32x10
[405.407403] Subtest cursor-random-32x10: SKIP (0.056s)
[405.514881] [102/130] (693s left) kms_chamelium_edid (hdmi-edid-read)
[405.659713] Subtest hdmi-edid-read: SKIP (0.000s)
[405.744715] [103/130] (693s left) gem_eio (wait-wedge-immediate)
[405.793813] Starting subtest: wait-wedge-immediate
[406.039027] Subtest wait-wedge-immediate: SUCCESS (0.244s)
[406.129046] [104/130] (692s left) gem_ctx_shared (exec-shared-gtt)
[406.174901] Starting subtest: exec-shared-gtt
[406.175700] Starting dynamic subtest: rcs0
[406.178994] Dynamic subtest rcs0: SUCCESS (0.004s)
[406.188788] Starting dynamic subtest: bcs0
[406.189511] Dynamic subtest bcs0: SUCCESS (0.002s)
[406.197681] Starting dynamic subtest: vcs0
[406.198398] Dynamic subtest vcs0: SUCCESS (0.003s)
[406.205782] Starting dynamic subtest: vcs1
[406.206503] Dynamic subtest vcs1: SUCCESS (0.002s)
[406.213337] Starting dynamic subtest: vecs0
[406.214055] Dynamic subtest vecs0: SUCCESS (0.002s)
[406.214748] Subtest exec-shared-gtt: SUCCESS (0.018s)
[406.359833] [105/130] (692s left) perf (invalid-oa-format-id)
[406.415956] Starting subtest: invalid-oa-format-id
[406.431784] Subtest invalid-oa-format-id: SUCCESS (0.016s)
[406.470577] [106/130] (692s left) gem_fenced_exec_thrash (2-spare-fences)
[406.510545] Starting subtest: 2-spare-fences
[408.667893] Subtest 2-spare-fences: SUCCESS (2.154s)
[408.745548] [107/130] (690s left) kms_flip (dpms-vs-vblank-race)
[408.839141] Starting subtest: dpms-vs-vblank-race
[408.843843] Starting dynamic subtest: A-HDMI-A1
[411.743803] Dynamic subtest A-HDMI-A1: SUCCESS (2.900s)
[411.751234] Starting dynamic subtest: B-HDMI-A1
[414.531325] Dynamic subtest B-HDMI-A1: SUCCESS (2.787s)
[414.541171] Starting dynamic subtest: C-HDMI-A1
[417.348866] Dynamic subtest C-HDMI-A1: SUCCESS (2.816s)
[417.356230] Starting dynamic subtest: D-HDMI-A1
[420.166139] Dynamic subtest D-HDMI-A1: SUCCESS (2.816s)
[420.168517] Subtest dpms-vs-vblank-race: SUCCESS (11.330s)
[420.280170] [108/130] (678s left) kms_async_flips (invalid-async-flip)
[420.389954] Starting subtest: invalid-async-flip
[420.498449] Starting dynamic subtest: pipe-A-HDMI-A-1
[420.642586] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.144s)
[420.756961] Starting dynamic subtest: pipe-B-HDMI-A-1
[420.837480] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.087s)
[420.938485] Starting dynamic subtest: pipe-C-HDMI-A-1
[421.027050] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.095s)
[421.131714] Starting dynamic subtest: pipe-D-HDMI-A-1
[421.232610] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.108s)
[421.233335] Subtest invalid-async-flip: SUCCESS (0.844s)
[421.413076] [109/130] (677s left) gen7_exec_parse (basic-offset)
[421.456582] Subtest basic-offset: SKIP (0.000s)
[421.496030] [110/130] (677s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-blt)
[421.592057] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-blt
[421.593540] Subtest fbc-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s)
[421.660834] [111/130] (677s left) syncobj_timeline (invalid-signal-one-illegal-handle)
[421.699103] Starting subtest: invalid-signal-one-illegal-handle
[421.699825] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s)
[421.745287] [112/130] (677s left) i915_pm_rpm (gem-idle)
[423.154524] Starting subtest: gem-idle
[429.401540] Subtest gem-idle: SUCCESS (6.249s)
[429.528147] [113/130] (669s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytileccs-downscaling)
[429.622413] Starting subtest: flip-32bpp-ytile-to-32bpp-ytileccs-downscaling
[429.623224] Starting dynamic subtest: pipe-A-valid-mode
[429.694797] Dynamic subtest pipe-A-valid-mode: SKIP (0.071s)
[429.696354] Subtest flip-32bpp-ytile-to-32bpp-ytileccs-downscaling: SKIP (0.073s)
[429.835078] [114/130] (669s left) kms_invalid_mode (zero-hdisplay)
[429.930959] Starting subtest: zero-hdisplay
[429.931668] Starting dynamic subtest: pipe-A-HDMI-A-1
[429.981669] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.049s)
[429.991579] Starting dynamic subtest: pipe-B-HDMI-A-1
[429.992343] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[430.001583] Starting dynamic subtest: pipe-C-HDMI-A-1
[430.002345] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[430.011833] Starting dynamic subtest: pipe-D-HDMI-A-1
[430.012619] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[430.013415] Subtest zero-hdisplay: SUCCESS (0.058s)
[430.103345] [115/130] (669s left) gem_mmap_wc (copy)
[430.145048] Starting subtest: copy
[430.293290] Subtest copy: SUCCESS (0.140s)
[430.326084] [116/130] (669s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size)
[430.415370] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size
[437.924936] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (7.475s)
[438.030433] [117/130] (661s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines)
[438.532916] Starting subtest: syncobj-stationary-timeline-chain-engines
[438.585810] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.061s)
[438.752726] [118/130] (660s left) kms_psr (pr-cursor-plane-onoff)
[438.843638] Subtest pr-cursor-plane-onoff: SKIP (0.000s)
[438.886696] [119/130] (660s left) kms_frontbuffer_tracking (fbc-tiling-linear)
[438.982697] Starting subtest: fbc-tiling-linear
[440.109888] Subtest fbc-tiling-linear: SUCCESS (1.128s)
[440.228962] [120/130] (659s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-move)
[440.333144] Starting subtest: psr-2p-scndscrn-cur-indfb-move
[440.334515] Subtest psr-2p-scndscrn-cur-indfb-move: SKIP (0.000s)
[440.401228] [121/130] (659s left) gem_exec_params (invalid-fence-in)
[440.443501] Starting subtest: invalid-fence-in
[440.444277] Subtest invalid-fence-in: SUCCESS (0.000s)
[440.529059] [122/130] (659s left) gem_exec_params (rs-invalid)
[440.569490] Starting subtest: rs-invalid
[440.573015] Subtest rs-invalid: SUCCESS (0.003s)
[440.684717] [123/130] (658s left) kms_flip (flip-vs-absolute-wf_vblank)
[440.776608] Starting subtest: flip-vs-absolute-wf_vblank
[440.778867] Starting dynamic subtest: A-HDMI-A1
[448.616431] Dynamic subtest A-HDMI-A1: SUCCESS (7.817s)
[448.624919] Starting dynamic subtest: B-HDMI-A1
[456.420307] Dynamic subtest B-HDMI-A1: SUCCESS (7.793s)
[456.427145] Starting dynamic subtest: C-HDMI-A1
[464.220570] Dynamic subtest C-HDMI-A1: SUCCESS (7.798s)
[464.227657] Starting dynamic subtest: D-HDMI-A1
[472.010491] Dynamic subtest D-HDMI-A1: SUCCESS (7.813s)
[472.011198] Subtest flip-vs-absolute-wf_vblank: SUCCESS (31.230s)
[472.141252] [124/130] (627s left) gem_exec_reloc (basic-gtt-read)
[472.182741] Starting subtest: basic-gtt-read
[472.189543] Subtest basic-gtt-read: SUCCESS (0.006s)
[472.291375] [125/130] (627s left) kms_psr (fbc-pr-sprite-plane-move)
[472.381092] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[472.417627] [126/130] (627s left) core_getstats
[472.500985] [127/130] (627s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[472.597469] Starting subtest: psr-1p-primscrn-spr-indfb-draw-mmap-gtt
[472.598880] Subtest psr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[472.670230] [128/130] (627s left) kms_cursor_crc (cursor-sliding-256x256)
[472.762458] Starting subtest: cursor-sliding-256x256
[472.767493] Starting dynamic subtest: pipe-A-HDMI-A-1
[474.614891] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.848s)
[474.659118] Starting dynamic subtest: pipe-D-HDMI-A-1
[476.478253] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.827s)
[476.479036] Subtest cursor-sliding-256x256: SUCCESS (3.717s)
[476.594991] [129/130] (623s left) gem_userptr_blits (mmap-offset-banned)
[476.648533] Starting subtest: mmap-offset-banned
[476.649357] Starting dynamic subtest: gtt
[476.650082] Dynamic subtest gtt: SUCCESS (0.000s)
[476.658304] Starting dynamic subtest: wb
[476.659044] Dynamic subtest wb: SUCCESS (0.000s)
[476.666526] Starting dynamic subtest: wc
[476.667251] Dynamic subtest wc: SUCCESS (0.000s)
[476.674374] Starting dynamic subtest: uc
[476.675112] Dynamic subtest uc: SUCCESS (0.000s)
[476.675812] Subtest mmap-offset-banned: SUCCESS (0.007s)
[476.774103] [130/130] (623s left) prime_mmap (test_correct)
[476.812394] Starting subtest: test_correct
[476.813156] Starting dynamic subtest: test_correct-smem
[476.815164] Dynamic subtest test_correct-smem: SUCCESS (0.002s)
[476.815922] Subtest test_correct: SUCCESS (0.003s)
[476.885962] Closing watchdogs
Done.