[49.363492] Initializing watchdogs
[49.363555]   /dev/watchdog0
[49.379282] [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]
[49.385327] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[49.387772] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[49.389688] [001/131] (960s left) syncobj_timeline (wait-any-complex)
[49.425234] Starting subtest: wait-any-complex
[49.488211] Subtest wait-any-complex: SUCCESS (0.062s)
[49.571866] [002/131] (960s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[49.658328] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[49.659060] Starting dynamic subtest: pipe-A-valid-mode
[50.508150] Dynamic subtest pipe-A-valid-mode: SUCCESS (0.849s)
[50.508842] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SUCCESS (0.850s)
[50.662283] [003/131] (959s left) sw_sync (sync_busy_fork_unixsocket)
[50.696909] Starting subtest: sync_busy_fork_unixsocket
[50.706017] Subtest sync_busy_fork_unixsocket: SUCCESS (0.009s)
[50.782920] [004/131] (959s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-wc)
[50.873406] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-wc
[50.874794] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[50.975764] [005/131] (959s left) api_intel_bb (full-batch)
[51.007956] Starting subtest: full-batch
[51.011141] Subtest full-batch: SUCCESS (0.003s)
[51.159921] [006/131] (958s left) kms_plane_cursor (primary)
[51.242592] Starting subtest: primary
[51.244018] Starting dynamic subtest: pipe-A-HDMI-A-1-size-64
[52.456875] Dynamic subtest pipe-A-HDMI-A-1-size-64: SUCCESS (1.213s)
[52.486798] Starting dynamic subtest: pipe-A-HDMI-A-1-size-128
[53.690262] Dynamic subtest pipe-A-HDMI-A-1-size-128: SUCCESS (1.209s)
[53.727456] Starting dynamic subtest: pipe-A-HDMI-A-1-size-256
[54.932386] Dynamic subtest pipe-A-HDMI-A-1-size-256: SUCCESS (1.217s)
[55.013632] Starting dynamic subtest: pipe-B-HDMI-A-1-size-64
[56.263896] Dynamic subtest pipe-B-HDMI-A-1-size-64: SUCCESS (1.255s)
[56.287076] Starting dynamic subtest: pipe-B-HDMI-A-1-size-128
[57.497351] Dynamic subtest pipe-B-HDMI-A-1-size-128: SUCCESS (1.217s)
[57.520868] Starting dynamic subtest: pipe-B-HDMI-A-1-size-256
[58.722421] Dynamic subtest pipe-B-HDMI-A-1-size-256: SUCCESS (1.208s)
[58.795156] Starting dynamic subtest: pipe-C-HDMI-A-1-size-64
[60.045228] Dynamic subtest pipe-C-HDMI-A-1-size-64: SUCCESS (1.255s)
[60.068274] Starting dynamic subtest: pipe-C-HDMI-A-1-size-128
[61.270280] Dynamic subtest pipe-C-HDMI-A-1-size-128: SUCCESS (1.208s)
[61.295834] Starting dynamic subtest: pipe-C-HDMI-A-1-size-256
[62.503754] Dynamic subtest pipe-C-HDMI-A-1-size-256: SUCCESS (1.217s)
[62.576335] Starting dynamic subtest: pipe-D-HDMI-A-1-size-64
[63.838861] Dynamic subtest pipe-D-HDMI-A-1-size-64: SUCCESS (1.267s)
[63.862995] Starting dynamic subtest: pipe-D-HDMI-A-1-size-128
[65.064210] Dynamic subtest pipe-D-HDMI-A-1-size-128: SUCCESS (1.208s)
[65.088881] Starting dynamic subtest: pipe-D-HDMI-A-1-size-256
[66.289221] Dynamic subtest pipe-D-HDMI-A-1-size-256: SUCCESS (1.208s)
[66.346285] Subtest primary: SUCCESS (15.103s)
[66.460814] [007/131] (943s left) syncobj_wait (invalid-multi-wait-unsubmitted-signaled)
[66.498716] Starting subtest: invalid-multi-wait-unsubmitted-signaled
[66.499417] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s)
[66.579999] [008/131] (943s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[66.669680] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[66.671088] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[66.895672] [009/131] (943s left) perf_pmu (faulting-read)
[66.954589] Starting subtest: faulting-read
[66.955317] Starting dynamic subtest: gtt
[66.956103] Dynamic subtest gtt: SUCCESS (0.001s)
[66.963109] Starting dynamic subtest: wb
[66.963810] Dynamic subtest wb: SUCCESS (0.001s)
[66.970291] Starting dynamic subtest: wc
[66.971730] Dynamic subtest wc: SUCCESS (0.000s)
[66.979175] Starting dynamic subtest: uc
[66.980499] Dynamic subtest uc: SUCCESS (0.001s)
[66.981831] Subtest faulting-read: SUCCESS (0.004s)
[67.319810] [010/131] (942s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-render)
[67.632232] Starting subtest: fbcpsr-rgb101010-draw-render
[67.633862] Subtest fbcpsr-rgb101010-draw-render: SKIP (0.000s)
[67.816224] [011/131] (942s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[67.916141] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[67.917924] Starting dynamic subtest: pipe-A-HDMI-A-1
[67.920940] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[67.928973] Starting dynamic subtest: pipe-B-HDMI-A-1
[67.932032] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[67.940408] Starting dynamic subtest: pipe-C-HDMI-A-1
[67.943468] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[67.951581] Starting dynamic subtest: pipe-D-HDMI-A-1
[67.954437] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[67.955927] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[68.189412] [012/131] (942s left) kms_chamelium_hpd (dp-hpd-for-each-pipe)
[68.332925] Subtest dp-hpd-for-each-pipe: SKIP (0.000s)
[68.417836] [013/131] (941s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[68.514776] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[68.516178] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[68.639523] [014/131] (941s left) prime_udl
[68.718876] [015/131] (941s left) kms_frontbuffer_tracking (psr-farfromfence-mmap-gtt)
[68.806455] Starting subtest: psr-farfromfence-mmap-gtt
[68.807804] Subtest psr-farfromfence-mmap-gtt: SKIP (0.000s)
[68.922895] [016/131] (941s left) kms_ccs (bad-pixel-format-y-tiled-gen12-rc-ccs-cc)
[69.005726] Starting subtest: bad-pixel-format-y-tiled-gen12-rc-ccs-cc
[69.006421] Starting dynamic subtest: pipe-A-HDMI-A-1
[69.012568] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.001s)
[69.018444] Starting dynamic subtest: pipe-B-HDMI-A-1
[69.024616] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.001s)
[69.030334] Starting dynamic subtest: pipe-C-HDMI-A-1
[69.036429] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.001s)
[69.042088] Starting dynamic subtest: pipe-D-HDMI-A-1
[69.048030] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.001s)
[69.048703] Subtest bad-pixel-format-y-tiled-gen12-rc-ccs-cc: SUCCESS (0.006s)
[69.252216] [017/131] (941s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[69.337631] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[69.338306] Starting dynamic subtest: pipe-A-HDMI-A-1
[69.344768] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s)
[69.350727] Starting dynamic subtest: pipe-B-HDMI-A-1
[69.357194] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s)
[69.362834] Starting dynamic subtest: pipe-C-HDMI-A-1
[69.369463] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.001s)
[69.375057] Starting dynamic subtest: pipe-D-HDMI-A-1
[69.381724] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.001s)
[69.383042] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.007s)
[69.576341] [018/131] (940s left) kms_big_fb (y-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[69.672621] Starting subtest: y-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[70.019825] Subtest y-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.347s)
[70.157623] [019/131] (940s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[70.190067] Starting subtest: basic-write-cpu-read-gtt
[70.424895] Subtest basic-write-cpu-read-gtt: SUCCESS (0.227s)
[70.528894] [020/131] (940s left) gem_exec_schedule (noreorder)
[70.690335] Starting subtest: noreorder
[70.691323] Starting dynamic subtest: rcs0
[70.742814] Dynamic subtest rcs0: SUCCESS (0.055s)
[70.758353] Starting dynamic subtest: bcs0
[70.801751] Dynamic subtest bcs0: SUCCESS (0.058s)
[70.816611] Starting dynamic subtest: vcs0
[70.865503] Dynamic subtest vcs0: SUCCESS (0.063s)
[70.881119] Starting dynamic subtest: vcs1
[70.921638] Dynamic subtest vcs1: SUCCESS (0.055s)
[70.936990] Starting dynamic subtest: vecs0
[70.975060] Dynamic subtest vecs0: SUCCESS (0.052s)
[70.976304] Subtest noreorder: SUCCESS (0.288s)
[71.174674] [021/131] (939s left) gen7_exec_parse (cmd-crossing-page)
[71.211675] Subtest cmd-crossing-page: SKIP (0.000s)
[71.248017] [022/131] (939s left) gem_exec_reloc (basic-wc-read-noreloc)
[71.284278] Starting subtest: basic-wc-read-noreloc
[71.287741] Subtest basic-wc-read-noreloc: SUCCESS (0.003s)
[71.410865] [023/131] (939s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-blt)
[71.501485] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-blt
[71.502852] Subtest fbc-2p-scndscrn-pri-indfb-draw-blt: SKIP (0.000s)
[71.616682] [024/131] (939s left) syncobj_basic (bad-flags-fd-to-handle)
[71.649528] Starting subtest: bad-flags-fd-to-handle
[71.650237] Subtest bad-flags-fd-to-handle: SUCCESS (0.000s)
[71.730097] [025/131] (939s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[71.763065] Starting subtest: framebuffer-vs-set-tiling
[71.763746] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[71.933880] [026/131] (938s left) kms_sequence (get-busy)
[72.016814] Starting subtest: get-busy
[72.018571] Starting dynamic subtest: pipe-A-HDMI-A-1
[73.321853] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.304s)
[73.330483] Starting dynamic subtest: pipe-B-HDMI-A-1
[74.595786] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.272s)
[74.602770] Starting dynamic subtest: pipe-C-HDMI-A-1
[75.877845] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.280s)
[75.885994] Starting dynamic subtest: pipe-D-HDMI-A-1
[77.159201] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.280s)
[77.159930] Subtest get-busy: SUCCESS (5.142s)
[77.278252] [027/131] (933s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-onoff)
[77.372384] Starting subtest: fbc-2p-primscrn-cur-indfb-onoff
[77.373705] Subtest fbc-2p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[77.485723] [028/131] (933s left) syncobj_timeline (multi-wait-for-submit-available-submitted)
[77.518963] Starting subtest: multi-wait-for-submit-available-submitted
[77.519681] Subtest multi-wait-for-submit-available-submitted: SUCCESS (0.001s)
[77.605705] [029/131] (933s left) i915_selftest (live)
[78.523903] Starting subtest: live
[78.524727] Starting dynamic subtest: sanitycheck
[79.797642] Dynamic subtest sanitycheck: SUCCESS (1.274s)
[79.805160] Starting dynamic subtest: uncore
[81.049523] Dynamic subtest uncore: SUCCESS (1.251s)
[81.056904] Starting dynamic subtest: workarounds
[82.759541] Dynamic subtest workarounds: SUCCESS (1.709s)
[82.767530] Starting dynamic subtest: gt_engines
[84.615495] Dynamic subtest gt_engines: SUCCESS (1.855s)
[84.620581] Starting dynamic subtest: gt_timelines
[93.192538] Dynamic subtest gt_timelines: SUCCESS (8.576s)
[93.200720] Starting dynamic subtest: gt_contexts
[94.608815] Dynamic subtest gt_contexts: SUCCESS (1.415s)
[94.616993] Starting dynamic subtest: gt_lrc
[98.881673] Dynamic subtest gt_lrc: SUCCESS (4.272s)
[98.893898] Starting dynamic subtest: gt_mocs
[100.296481] Dynamic subtest gt_mocs: SUCCESS (1.414s)
[100.301778] Starting dynamic subtest: gt_pm
[121.754636] Dynamic subtest gt_pm: SUCCESS (21.457s)
[121.763021] Starting dynamic subtest: gt_heartbeat
[123.027619] Dynamic subtest gt_heartbeat: SUCCESS (1.272s)
[123.041436] Starting dynamic subtest: gt_tlb
[126.534635] Dynamic subtest gt_tlb: SUCCESS (3.506s)
[126.539910] Starting dynamic subtest: requests
[135.178776] Dynamic subtest requests: SUCCESS (8.643s)
[135.186263] Starting dynamic subtest: migrate
[139.546714] Dynamic subtest migrate: SUCCESS (4.367s)
[139.554672] Starting dynamic subtest: active
[140.817515] Dynamic subtest active: SUCCESS (1.269s)
[140.822968] Starting dynamic subtest: objects
[142.549607] Dynamic subtest objects: SUCCESS (1.731s)
[142.561239] Starting dynamic subtest: mman
[147.255619] Dynamic subtest mman: SUCCESS (4.704s)
[147.264749] Starting dynamic subtest: dmabuf
[148.600676] Dynamic subtest dmabuf: SUCCESS (1.343s)
[148.608885] Starting dynamic subtest: vma
[149.897609] Dynamic subtest vma: SUCCESS (1.295s)
[149.911350] Starting dynamic subtest: coherency
[152.860453] Dynamic subtest coherency: SUCCESS (2.961s)
[152.874746] Starting dynamic subtest: gtt
[161.937422] Dynamic subtest gtt: SUCCESS (9.075s)
[161.942709] Starting dynamic subtest: gem
[164.142402] Dynamic subtest gem: SUCCESS (2.203s)
[164.154320] Starting dynamic subtest: evict
[166.379686] Dynamic subtest evict: SUCCESS (2.235s)
[166.387483] Starting dynamic subtest: hugepages
[174.268860] Dynamic subtest hugepages: SUCCESS (7.887s)
[174.280432] Starting dynamic subtest: gem_contexts
[189.947564] Dynamic subtest gem_contexts: SUCCESS (15.677s)
[189.953022] Starting dynamic subtest: client
[191.205600] Dynamic subtest client: SUCCESS (1.256s)
[191.213362] Starting dynamic subtest: gem_migrate
[192.447693] Dynamic subtest gem_migrate: SUCCESS (1.240s)
[192.455278] Starting dynamic subtest: reset
[197.405689] Dynamic subtest reset: SUCCESS (4.956s)
[197.419772] Starting dynamic subtest: memory_region
[198.684591] Dynamic subtest memory_region: SUCCESS (1.277s)
[198.694399] Starting dynamic subtest: hangcheck
[228.793631] Dynamic subtest hangcheck: SUCCESS (30.107s)
[228.799676] Starting dynamic subtest: execlists
[242.822551] Dynamic subtest execlists: SUCCESS (14.027s)
[242.830867] Starting dynamic subtest: ring_submission
[244.051791] Dynamic subtest ring_submission: SUCCESS (1.227s)
[244.060319] Starting dynamic subtest: perf
[245.398577] Dynamic subtest perf: SUCCESS (1.345s)
[245.406450] Starting dynamic subtest: slpc
[246.657623] Dynamic subtest slpc: SUCCESS (1.257s)
[246.665575] Starting dynamic subtest: guc
[247.927620] Dynamic subtest guc: SUCCESS (1.268s)
[247.935241] Starting dynamic subtest: guc_multi_lrc
[249.196883] Dynamic subtest guc_multi_lrc: SUCCESS (1.267s)
[249.205273] Starting dynamic subtest: guc_hang
[250.433487] Dynamic subtest guc_hang: SUCCESS (1.235s)
[250.441390] Starting dynamic subtest: late_gt_pm
[251.727494] Dynamic subtest late_gt_pm: SUCCESS (1.292s)
[251.728211] Subtest live: SUCCESS (173.205s)
[251.750808] [FACT i915_selftest (live)] deleted: kernel.kmod_is_loaded.i915: true
[251.753289] [030/131] (759s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)
[252.865131] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc
[252.866533] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[252.952770] [FACT kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-wc)] new: kernel.kmod_is_loaded.i915: true
[252.955289] [031/131] (758s left) kms_cursor_crc (cursor-offscreen-32x10)
[253.043325] Starting subtest: cursor-offscreen-32x10
[253.096765] Subtest cursor-offscreen-32x10: SKIP (0.052s)
[253.224870] [032/131] (757s left) i915_pm_freq_api (freq-suspend)
[253.263553] Subtest freq-suspend: SKIP (0.000s)
[253.306647] [033/131] (757s left) api_intel_allocator (reopen)
[253.338243] Starting subtest: reopen
[253.342256] Subtest reopen: SUCCESS (0.004s)
[253.475581] [034/131] (757s left) gem_ctx_persistence (engines-mixed)
[253.511222] Starting subtest: engines-mixed
[253.511963] Starting dynamic subtest: rcs0
[253.558755] Dynamic subtest rcs0: SUCCESS (0.047s)
[253.573898] Starting dynamic subtest: bcs0
[253.621799] Dynamic subtest bcs0: SUCCESS (0.061s)
[253.641194] Starting dynamic subtest: vcs0
[253.684784] Dynamic subtest vcs0: SUCCESS (0.060s)
[253.703689] Starting dynamic subtest: vcs1
[253.762652] Dynamic subtest vcs1: SUCCESS (0.075s)
[253.781883] Starting dynamic subtest: vecs0
[253.914467] Dynamic subtest vecs0: SUCCESS (0.141s)
[253.915200] Subtest engines-mixed: SUCCESS (0.395s)
[253.979196] [035/131] (757s left) gem_eio (in-flight-internal-1us)
[254.147108] Starting subtest: in-flight-internal-1us
[254.414048] Subtest in-flight-internal-1us: SUCCESS (0.268s)
[254.555071] [036/131] (756s left) i915_pm_freq_mult (media-freq)
[254.587172] Starting subtest: media-freq
[254.587933] Starting dynamic subtest: gt0
[254.589336] Dynamic subtest gt0: SKIP (0.000s)
[254.590730] Subtest media-freq: SKIP (0.001s)
[254.673076] [037/131] (756s left) gem_fenced_exec_thrash (too-many-fences)
[254.708417] Starting subtest: too-many-fences
[256.863985] Subtest too-many-fences: SUCCESS (2.155s)
[257.002462] [038/131] (754s left) gem_exec_balancer (invalid-balancer)
[257.044164] Starting subtest: invalid-balancer
[258.323820] Subtest invalid-balancer: SUCCESS (1.271s)
[258.527308] [039/131] (752s left) gem_ccs (block-multicopy-compressed)
[258.562874] Starting subtest: block-multicopy-compressed
[258.564262] Subtest block-multicopy-compressed: SKIP (0.000s)
[258.648188] [040/131] (752s left) kms_lease (setcrtc-implicit-plane)
[258.735957] Starting subtest: setcrtc-implicit-plane
[258.737751] Starting dynamic subtest: pipe-A-HDMI-A-1
[258.936236] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.199s)
[258.944091] Starting dynamic subtest: pipe-B-HDMI-A-1
[259.107821] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.170s)
[259.115808] Starting dynamic subtest: pipe-C-HDMI-A-1
[259.277495] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.168s)
[259.289930] Starting dynamic subtest: pipe-D-HDMI-A-1
[259.446496] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.167s)
[259.447221] Subtest setcrtc-implicit-plane: SUCCESS (0.711s)
[259.616081] [041/131] (751s left) kms_pm_rpm (basic-rte)
[259.647642] Starting subtest: basic-rte
[272.352020] Subtest basic-rte: SUCCESS (12.705s)
[273.732592] [042/131] (737s left) gem_exec_whisper (basic-fds-priority-all)
[273.773331] Starting subtest: basic-fds-priority-all
[277.919036] Subtest basic-fds-priority-all: SUCCESS (4.145s)
[278.127603] [043/131] (733s left) syncobj_wait (wait-for-submit-delayed-submit)
[278.161083] Starting subtest: wait-for-submit-delayed-submit
[278.264748] Subtest wait-for-submit-delayed-submit: SUCCESS (0.102s)
[278.351957] [044/131] (733s left) kms_flip (2x-flip-vs-rmfb)
[278.440856] Starting subtest: 2x-flip-vs-rmfb
[278.450419] Subtest 2x-flip-vs-rmfb: SKIP (0.009s)
[278.537570] [045/131] (733s left) gem_exec_alignment (single)
[278.573738] Starting subtest: single
[278.576218] Subtest single: SUCCESS (0.003s)
[278.709568] [046/131] (732s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-msflip-blt)
[278.798691] Starting subtest: fbc-2p-scndscrn-indfb-msflip-blt
[278.800037] Subtest fbc-2p-scndscrn-indfb-msflip-blt: SKIP (0.000s)
[278.917416] [047/131] (732s left) kms_psr (psr-dpms)
[279.004624] Subtest psr-dpms: SKIP (0.000s)
[279.040709] [048/131] (732s left) dumb_buffer (invalid-bpp)
[279.072654] Starting subtest: invalid-bpp
[279.073345] Subtest invalid-bpp: SUCCESS (0.000s)
[279.157475] [049/131] (732s left) gem_ctx_param (basic-default)
[279.190784] Starting subtest: basic-default
[279.191456] Subtest basic-default: SUCCESS (0.000s)
[279.276791] [050/131] (732s left) syncobj_timeline (invalid-signal-zero-handles)
[279.310059] Starting subtest: invalid-signal-zero-handles
[279.310789] Subtest invalid-signal-zero-handles: SUCCESS (0.000s)
[279.398599] [051/131] (732s left) gem_pxp (hw-rejects-pxp-context)
[279.499179] Starting subtest: hw-rejects-pxp-context
[279.501024] Subtest hw-rejects-pxp-context: SKIP (0.000s)
[279.594546] [052/131] (732s left) sw_sync (sync_random_merge)
[279.625947] Starting subtest: sync_random_merge
[279.682849] Subtest sync_random_merge: SUCCESS (0.057s)
[279.746655] [053/131] (732s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf)
[279.833635] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s)
[279.875077] [054/131] (732s left) gem_userptr_blits (invalid-mmap-offset-unsync)
[279.912886] Subtest invalid-mmap-offset-unsync: SKIP (0.000s)
[280.059960] [055/131] (731s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[280.149699] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[280.151095] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[280.258451] [056/131] (731s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[280.354969] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip
[280.356281] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s)
[280.458810] [057/131] (731s left) perf_pmu (all-busy-check-all)
[280.493950] Starting subtest: all-busy-check-all
[281.015060] Subtest all-busy-check-all: SUCCESS (0.521s)
[281.105827] [058/131] (730s left) gem_exec_params (no-bsd)
[281.142690] Starting subtest: no-bsd
[281.143377] Subtest no-bsd: SUCCESS (0.001s)
[281.284905] [059/131] (730s left) kms_cursor_crc (cursor-rapid-movement-256x256)
[281.373753] Starting subtest: cursor-rapid-movement-256x256
[281.378895] Starting dynamic subtest: pipe-A-HDMI-A-1
[281.637054] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.258s)
[281.668322] Starting dynamic subtest: pipe-D-HDMI-A-1
[281.882610] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.220s)
[281.883298] Subtest cursor-rapid-movement-256x256: SUCCESS (0.509s)
[282.049950] [060/131] (730s left) kms_psr (psr-sprite-plane-move)
[282.134771] Subtest psr-sprite-plane-move: SKIP (0.000s)
[282.174647] [061/131] (730s left) kms_big_fb (4-tiled-8bpp-rotate-90)
[282.269804] Starting subtest: 4-tiled-8bpp-rotate-90
[282.271255] Subtest 4-tiled-8bpp-rotate-90: SKIP (0.000s)
[282.376184] [062/131] (729s left) kms_cursor_crc (cursor-sliding-256x256)
[282.465345] Starting subtest: cursor-sliding-256x256
[282.470859] Starting dynamic subtest: pipe-A-HDMI-A-1
[284.311277] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.841s)
[284.343976] Starting dynamic subtest: pipe-D-HDMI-A-1
[286.151677] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.813s)
[286.152360] Subtest cursor-sliding-256x256: SUCCESS (3.687s)
[286.307388] [063/131] (725s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-blt)
[286.397722] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-blt
[286.399074] Subtest fbc-2p-scndscrn-spr-indfb-draw-blt: SKIP (0.000s)
[286.509490] [064/131] (725s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt)
[286.597332] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt
[286.598763] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s)
[286.709147] [065/131] (725s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-shrfb-pgflip-blt)
[286.796810] Starting subtest: fbc-2p-scndscrn-shrfb-pgflip-blt
[286.798183] Subtest fbc-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[286.918357] [066/131] (725s left) gem_sync (basic-each)
[286.959093] Starting subtest: basic-each
[289.105669] Subtest basic-each: SUCCESS (2.146s)
[289.310346] [067/131] (723s left) gem_spin_batch (resubmit-all)
[289.351305] Starting subtest: resubmit-all
[289.352067] Starting dynamic subtest: rcs0
[289.355620] Dynamic subtest rcs0: SUCCESS (0.004s)
[289.366899] Starting dynamic subtest: bcs0
[289.367681] Dynamic subtest bcs0: SUCCESS (0.003s)
[289.376404] Starting dynamic subtest: vcs0
[289.377089] Dynamic subtest vcs0: SUCCESS (0.003s)
[289.383866] Starting dynamic subtest: vcs1
[289.384532] Dynamic subtest vcs1: SUCCESS (0.002s)
[289.390919] Starting dynamic subtest: vecs0
[289.391605] Dynamic subtest vecs0: SUCCESS (0.002s)
[289.392262] Subtest resubmit-all: SUCCESS (0.022s)
[289.578434] [068/131] (722s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[289.611140] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[289.611869] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[289.699992] [069/131] (722s left) gem_mmap_gtt (hang)
[289.731989] Starting subtest: hang
[295.169101] Subtest hang: SUCCESS (5.437s)
[295.274035] [070/131] (717s left) gem_mmap_gtt (fault-concurrent-x)
[295.310996] Starting subtest: fault-concurrent-X
[298.039262] Subtest fault-concurrent-X: SUCCESS (2.695s)
[298.114547] [071/131] (714s left) gem_exec_alignment (forked)
[298.156073] Starting subtest: forked
[337.059067] Subtest forked: SUCCESS (38.894s)
[337.135011] [072/131] (675s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt)
[337.261732] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt
[337.263114] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s)
[337.384182] [073/131] (675s left) kms_dirtyfb (drrs-dirtyfb-ioctl)
[337.472460] Starting subtest: drrs-dirtyfb-ioctl
[337.476623] Subtest drrs-dirtyfb-ioctl: SKIP (0.001s)
[337.584765] [074/131] (675s left) gem_exec_fence (concurrent)
[337.751644] Starting subtest: concurrent
[337.752781] Starting dynamic subtest: rcs0
[337.789724] Dynamic subtest rcs0: SUCCESS (0.037s)
[337.806964] Starting dynamic subtest: bcs0
[337.822758] Dynamic subtest bcs0: SUCCESS (0.031s)
[337.839584] Starting dynamic subtest: vcs0
[337.856489] Dynamic subtest vcs0: SUCCESS (0.031s)
[337.874689] Starting dynamic subtest: vcs1
[337.890474] Dynamic subtest vcs1: SUCCESS (0.032s)
[337.906172] Starting dynamic subtest: vecs0
[337.925741] Dynamic subtest vecs0: SUCCESS (0.032s)
[337.926821] Subtest concurrent: SUCCESS (0.174s)
[338.435824] [FACT gem_exec_fence (concurrent)] new: kernel.kmod_is_loaded.vgem: true
[338.439066] [075/131] (674s left) kms_hdr (bpc-switch-suspend)
[338.526201] Starting subtest: bpc-switch-suspend
[338.528401] Subtest bpc-switch-suspend: SKIP (0.001s)
[338.618953] [076/131] (674s left) sysfs_preempt_timeout (timeout)
[338.655019] Starting subtest: timeout
[338.656843] Starting dynamic subtest: vecs0
[339.634835] Dynamic subtest vecs0: SUCCESS (0.978s)
[339.651819] Starting dynamic subtest: vcs0
[340.583518] Dynamic subtest vcs0: SUCCESS (0.946s)
[340.597330] Starting dynamic subtest: bcs0
[341.553705] Dynamic subtest bcs0: SUCCESS (0.968s)
[341.564969] Starting dynamic subtest: rcs0
[342.495473] Dynamic subtest rcs0: SUCCESS (0.939s)
[342.509215] Starting dynamic subtest: vcs1
[343.435684] Dynamic subtest vcs1: SUCCESS (0.938s)
[343.436734] Subtest timeout: SUCCESS (4.781s)
[343.524336] [077/131] (669s left) kms_psr (fbc-psr2-sprite-plane-move)
[343.619501] Subtest fbc-psr2-sprite-plane-move: SKIP (0.000s)
[343.670423] [078/131] (669s left) kms_psr2_sf (pr-overlay-plane-move-continuous-sf)
[343.761103] Subtest pr-overlay-plane-move-continuous-sf: SKIP (0.000s)
[343.806528] [079/131] (669s left) kms_psr (pr-cursor-mmap-gtt)
[343.894702] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[343.937205] [080/131] (669s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[344.024038] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[344.025776] Starting dynamic subtest: pipe-A-valid-mode
[344.079347] Dynamic subtest pipe-A-valid-mode: SKIP (0.053s)
[344.080776] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.055s)
[344.207600] [081/131] (668s left) kms_busy (extended-modeset-hang-newfb-with-reset)
[344.307054] Starting subtest: extended-modeset-hang-newfb-with-reset
[344.308770] Starting dynamic subtest: pipe-A
[347.169282] Dynamic subtest pipe-A: SUCCESS (2.860s)
[347.179827] Starting dynamic subtest: pipe-D
[350.027527] Dynamic subtest pipe-D: SUCCESS (2.855s)
[350.028240] Subtest extended-modeset-hang-newfb-with-reset: SUCCESS (5.721s)
[350.233117] [082/131] (662s left) gem_pwrite (basic-exhaustion)
[350.267421] Starting subtest: basic-exhaustion
[353.628216] Subtest basic-exhaustion: SUCCESS (3.353s)
[353.810165] [083/131] (659s left) gem_caching (writes)
[353.847752] Starting subtest: writes
[363.039254] Subtest writes: SUCCESS (9.191s)
[363.186064] [084/131] (649s left) perf_pmu (busy-idle-check-all)
[363.223066] Starting subtest: busy-idle-check-all
[363.223840] Starting dynamic subtest: rcs0
[363.845848] Dynamic subtest rcs0: SUCCESS (0.621s)
[363.857043] Starting dynamic subtest: bcs0
[364.468657] Dynamic subtest bcs0: SUCCESS (0.618s)
[364.477450] Starting dynamic subtest: vcs0
[365.094267] Dynamic subtest vcs0: SUCCESS (0.627s)
[365.106208] Starting dynamic subtest: vcs1
[365.724233] Dynamic subtest vcs1: SUCCESS (0.628s)
[365.736159] Starting dynamic subtest: vecs0
[366.354498] Dynamic subtest vecs0: SUCCESS (0.628s)
[366.355726] Subtest busy-idle-check-all: SUCCESS (3.132s)
[366.454256] [085/131] (646s left) gen9_exec_parse (unaligned-jump)
[366.490093] Subtest unaligned-jump: SKIP (0.000s)
[366.533646] [086/131] (646s left) kms_frontbuffer_tracking (psr-2p-scndscrn-spr-indfb-onoff)
[366.624497] Starting subtest: psr-2p-scndscrn-spr-indfb-onoff
[366.625900] Subtest psr-2p-scndscrn-spr-indfb-onoff: SKIP (0.000s)
[366.755385] [087/131] (646s left) gem_lmem_swapping (parallel-random)
[366.792783] Subtest parallel-random: SKIP (0.000s)
[366.833328] [088/131] (646s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-async-flip)
[366.931477] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-async-flip
[367.252697] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-async-flip: SUCCESS (0.321s)
[367.394307] [089/131] (645s left) gem_ctx_bad_destroy (invalid-default-ctx)
[367.427377] Starting subtest: invalid-default-ctx
[367.428099] Subtest invalid-default-ctx: SUCCESS (0.000s)
[367.511201] [090/131] (645s left) syncobj_eventfd (invalid-illegal-handle)
[367.546378] Starting subtest: invalid-illegal-handle
[367.547084] Subtest invalid-illegal-handle: SUCCESS (0.000s)
[367.638262] [091/131] (645s left) kms_async_flips (async-flip-suspend-resume)
[367.723168] Starting subtest: async-flip-suspend-resume
[367.848616] Starting dynamic subtest: pipe-A-HDMI-A-1
[385.787102] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.907s)
[385.912082] Starting dynamic subtest: pipe-B-HDMI-A-1
[403.787439] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.246s)
[403.907697] Starting dynamic subtest: pipe-C-HDMI-A-1
[421.772550] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.234s)
[421.889496] Starting dynamic subtest: pipe-D-HDMI-A-1
[439.789142] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.298s)
[439.789886] Subtest async-flip-suspend-resume: SUCCESS (10.145s)
[448.047224] [092/131] (573s left) gem_ctx_persistence (hang)
[448.086620] Starting subtest: hang
[448.088410] Subtest hang: SUCCESS (0.001s)
[448.174851] [093/131] (573s left) gem_exec_parallel (userptr)
[448.215069] Starting subtest: userptr
[448.215831] Starting dynamic subtest: rcs0
[449.862566] Dynamic subtest rcs0: SUCCESS (1.647s)
[449.872843] Starting dynamic subtest: bcs0
[451.519502] Dynamic subtest bcs0: SUCCESS (1.655s)
[451.529199] Starting dynamic subtest: vcs0
[453.116409] Dynamic subtest vcs0: SUCCESS (1.596s)
[453.126748] Starting dynamic subtest: vcs1
[454.723924] Dynamic subtest vcs1: SUCCESS (1.606s)
[454.737448] Starting dynamic subtest: vecs0
[456.345389] Dynamic subtest vecs0: SUCCESS (1.620s)
[456.346157] Subtest userptr: SUCCESS (8.128s)
[456.549485] [094/131] (565s left) kms_cdclk (mode-transition-all-outputs)
[456.582543] Subtest mode-transition-all-outputs: SKIP (0.000s)
[456.621488] [095/131] (565s left) kms_ccs (random-ccs-data-4-tiled-dg2-rc-ccs)
[456.708939] Starting subtest: random-ccs-data-4-tiled-dg2-rc-ccs
[456.709713] Starting dynamic subtest: pipe-A-HDMI-A-1
[456.717367] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.000s)
[456.725979] Starting dynamic subtest: pipe-B-HDMI-A-1
[456.733750] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.000s)
[456.742517] Starting dynamic subtest: pipe-C-HDMI-A-1
[456.749896] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[456.758294] Starting dynamic subtest: pipe-D-HDMI-A-1
[456.765955] Dynamic subtest pipe-D-HDMI-A-1: SKIP (0.000s)
[456.767289] Subtest random-ccs-data-4-tiled-dg2-rc-ccs: SKIP (0.008s)
[456.974843] [096/131] (564s left) kms_cursor_legacy (2x-long-flip-vs-cursor-legacy)
[457.060013] Starting subtest: 2x-long-flip-vs-cursor-legacy
[457.062680] Subtest 2x-long-flip-vs-cursor-legacy: SKIP (0.002s)
[457.141465] [097/131] (564s left) gem_close_race (multigpu-basic-threads)
[457.184146] Starting subtest: multigpu-basic-threads
[457.185554] Subtest multigpu-basic-threads: SKIP (0.000s)
[457.383630] [098/131] (564s left) gem_render_copy (y-tiled-to-vebox-yf-tiled)
[457.422130] Starting subtest: y-tiled-to-vebox-yf-tiled
[457.422853] Starting dynamic subtest: smem
[457.492253] Dynamic subtest smem: SUCCESS (0.069s)
[457.493059] Subtest y-tiled-to-vebox-yf-tiled: SUCCESS (0.070s)
[457.687740] [099/131] (564s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-indfb-pgflip-blt)
[457.777116] Starting subtest: fbcpsr-2p-scndscrn-indfb-pgflip-blt
[457.778588] Subtest fbcpsr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s)
[457.900801] [100/131] (563s left) kms_frontbuffer_tracking (fbcpsr-2p-indfb-fliptrack-mmap-gtt)
[457.991360] Starting subtest: fbcpsr-2p-indfb-fliptrack-mmap-gtt
[457.992812] Subtest fbcpsr-2p-indfb-fliptrack-mmap-gtt: SKIP (0.000s)
[458.100390] [101/131] (563s left) gem_exec_fence (invalid-timeline-fence-array)
[458.574367] Starting subtest: invalid-timeline-fence-array
[458.575233] Subtest invalid-timeline-fence-array: SUCCESS (0.007s)
[458.771689] [102/131] (563s left) kms_flip (2x-blocking-wf_vblank)
[458.856762] Starting subtest: 2x-blocking-wf_vblank
[458.865929] Subtest 2x-blocking-wf_vblank: SKIP (0.009s)
[458.965918] [103/131] (562s left) kms_flip (absolute-wf_vblank-interruptible)
[459.054091] Starting subtest: absolute-wf_vblank-interruptible
[459.056953] Starting dynamic subtest: A-HDMI-A1
[466.725006] Dynamic subtest A-HDMI-A1: SUCCESS (7.647s)
[466.733726] Starting dynamic subtest: B-HDMI-A1
[474.335265] Dynamic subtest B-HDMI-A1: SUCCESS (7.623s)
[474.349912] Starting dynamic subtest: C-HDMI-A1
[481.988773] Dynamic subtest C-HDMI-A1: SUCCESS (7.627s)
[481.997493] Starting dynamic subtest: D-HDMI-A1
[489.594360] Dynamic subtest D-HDMI-A1: SUCCESS (7.627s)
[489.595401] Subtest absolute-wf_vblank-interruptible: SUCCESS (30.536s)
[489.799847] [104/131] (532s left) gem_exec_schedule (u-fairslice)
[489.841906] Starting subtest: u-fairslice
[489.842636] Starting dynamic subtest: rcs0
[491.864492] Dynamic subtest rcs0: SUCCESS (2.012s)
[491.876117] Starting dynamic subtest: bcs0
[493.877765] Dynamic subtest bcs0: SUCCESS (2.012s)
[493.889410] Starting dynamic subtest: vcs0
[495.889718] Dynamic subtest vcs0: SUCCESS (2.011s)
[495.901627] Starting dynamic subtest: vcs1
[497.902956] Dynamic subtest vcs1: SUCCESS (2.012s)
[497.914757] Starting dynamic subtest: vecs0
[499.914232] Dynamic subtest vecs0: SUCCESS (2.010s)
[499.915135] Subtest u-fairslice: SUCCESS (10.063s)
[500.221705] [105/131] (521s left) kms_psr (fbc-pr-primary-page-flip)
[500.308348] Subtest fbc-pr-primary-page-flip: SKIP (0.000s)
[500.351790] [106/131] (521s left) kms_big_fb (x-tiled-64bpp-rotate-270)
[500.443990] Starting subtest: x-tiled-64bpp-rotate-270
[500.492073] Subtest x-tiled-64bpp-rotate-270: SKIP (0.047s)
[500.637039] [107/131] (521s left) kms_draw_crc (draw-method-mmap-cpu)
[500.721610] Starting subtest: draw-method-mmap-cpu
[500.722375] Starting dynamic subtest: xrgb8888-untiled
[500.868706] Dynamic subtest xrgb8888-untiled: SUCCESS (0.146s)
[500.887140] Starting dynamic subtest: rgb565-untiled
[501.027151] Dynamic subtest rgb565-untiled: SUCCESS (0.156s)
[501.045695] Starting dynamic subtest: xrgb2101010-untiled
[501.168943] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.139s)
[501.188790] Starting dynamic subtest: xbgr16161616f-untiled
[501.318862] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.147s)
[501.335933] Starting dynamic subtest: xrgb8888-xtiled
[501.410674] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.089s)
[501.429697] Starting dynamic subtest: rgb565-xtiled
[501.502211] Dynamic subtest rgb565-xtiled: SUCCESS (0.089s)
[501.521150] Starting dynamic subtest: xrgb2101010-xtiled
[501.585704] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.081s)
[501.605486] Starting dynamic subtest: xbgr16161616f-xtiled
[501.668759] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.080s)
[501.685463] Starting dynamic subtest: xrgb8888-ytiled
[501.760423] Dynamic subtest xrgb8888-ytiled: SUCCESS (0.090s)
[501.777041] Starting dynamic subtest: rgb565-ytiled
[501.852463] Dynamic subtest rgb565-ytiled: SUCCESS (0.090s)
[501.870313] Starting dynamic subtest: xrgb2101010-ytiled
[501.935545] Dynamic subtest xrgb2101010-ytiled: SUCCESS (0.081s)
[501.954594] Starting dynamic subtest: xbgr16161616f-ytiled
[502.018868] Dynamic subtest xbgr16161616f-ytiled: SUCCESS (0.081s)
[502.022102] Subtest draw-method-mmap-cpu: SUCCESS (1.298s)
[502.143888] [108/131] (520s left) gem_exec_reloc (basic-wc-cpu)
[502.182378] Starting subtest: basic-wc-cpu
[502.188183] Subtest basic-wc-cpu: SUCCESS (0.006s)
[502.333810] [109/131] (519s left) kms_plane (plane-position-hole-dpms)
[502.418075] Starting subtest: plane-position-hole-dpms
[502.619343] Starting dynamic subtest: pipe-A-plane-1
[502.939835] Dynamic subtest pipe-A-plane-1: SUCCESS (0.322s)
[502.950848] Starting dynamic subtest: pipe-A-plane-2
[503.260976] Dynamic subtest pipe-A-plane-2: SUCCESS (0.320s)
[503.272170] Starting dynamic subtest: pipe-A-plane-3
[503.596170] Dynamic subtest pipe-A-plane-3: SUCCESS (0.334s)
[503.605307] Starting dynamic subtest: pipe-A-plane-4
[503.916905] Dynamic subtest pipe-A-plane-4: SUCCESS (0.319s)
[503.926892] Starting dynamic subtest: pipe-A-plane-5
[504.244097] Dynamic subtest pipe-A-plane-5: SUCCESS (0.326s)
[504.255187] Starting dynamic subtest: pipe-A-plane-6
[504.582776] Dynamic subtest pipe-A-plane-6: SUCCESS (0.337s)
[504.591606] Starting dynamic subtest: pipe-A-plane-7
[504.592948] Dynamic subtest pipe-A-plane-7: SUCCESS (0.002s)
[504.771056] Starting dynamic subtest: pipe-B-plane-1
[505.065781] Dynamic subtest pipe-B-plane-1: SUCCESS (0.303s)
[505.074636] Starting dynamic subtest: pipe-B-plane-2
[505.386689] Dynamic subtest pipe-B-plane-2: SUCCESS (0.320s)
[505.395567] Starting dynamic subtest: pipe-B-plane-3
[505.691549] Dynamic subtest pipe-B-plane-3: SUCCESS (0.304s)
[505.700359] Starting dynamic subtest: pipe-B-plane-4
[506.013443] Dynamic subtest pipe-B-plane-4: SUCCESS (0.321s)
[506.023343] Starting dynamic subtest: pipe-B-plane-5
[506.332517] Dynamic subtest pipe-B-plane-5: SUCCESS (0.318s)
[506.342451] Starting dynamic subtest: pipe-B-plane-6
[506.644383] Dynamic subtest pipe-B-plane-6: SUCCESS (0.310s)
[506.653173] Starting dynamic subtest: pipe-B-plane-7
[506.654507] Dynamic subtest pipe-B-plane-7: SUCCESS (0.002s)
[506.655180] Subtest plane-position-hole-dpms: SUCCESS (4.230s)
[506.809771] [110/131] (515s left) kms_chamelium_frames (dp-crc-single)
[506.953152] Subtest dp-crc-single: SKIP (0.000s)
[507.038351] [111/131] (515s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-blt)
[507.132728] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-blt
[507.134075] Subtest psr-1p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s)
[507.228596] [112/131] (515s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen)
[507.317011] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen
[507.318430] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s)
[507.438563] [113/131] (514s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted)
[507.474072] Starting subtest: invalid-multi-wait-unsubmitted-submitted
[507.474841] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s)
[507.561274] [114/131] (514s left) kms_properties (invalid-properties-atomic)
[507.647004] Starting subtest: invalid-properties-atomic
[508.212593] Subtest invalid-properties-atomic: SUCCESS (0.558s)
[508.291834] [115/131] (514s left) gem_exec_suspend (basic-s3)
[508.331301] Starting subtest: basic-S3
[508.332084] Starting dynamic subtest: smem
[526.220812] Dynamic subtest smem: SUCCESS (2.570s)
[526.221542] Subtest basic-S3: SUCCESS (2.571s)
[534.460426] [116/131] (496s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-downscaling)
[534.562426] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-downscaling
[534.564284] Starting dynamic subtest: pipe-A-valid-mode
[534.617390] Dynamic subtest pipe-A-valid-mode: SKIP (0.053s)
[534.619001] Subtest flip-64bpp-4tile-to-16bpp-4tile-downscaling: SKIP (0.055s)
[534.744742] [117/131] (495s left) kms_psr (fbc-psr-primary-page-flip)
[534.830093] Subtest fbc-psr-primary-page-flip: SKIP (0.000s)
[534.871860] [118/131] (495s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move)
[534.959784] Starting subtest: fbc-2p-primscrn-spr-indfb-move
[534.961191] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s)
[535.091492] [119/131] (495s left) kms_joiner (invalid-modeset-force-ultra-joiner)
[535.179217] Starting subtest: invalid-modeset-force-ultra-joiner
[535.180661] Subtest invalid-modeset-force-ultra-joiner: SKIP (0.000s)
[535.288404] [120/131] (495s left) kms_prop_blob (blob-multiple)
[535.321615] Starting subtest: blob-multiple
[535.323476] Subtest blob-multiple: SUCCESS (0.001s)
[535.413618] [121/131] (495s left) kms_vblank (wait-forked-busy)
[535.499146] Starting subtest: wait-forked-busy
[535.499840] Starting dynamic subtest: pipe-A-HDMI-A-1
[536.782034] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.281s)
[536.794059] Starting dynamic subtest: pipe-D-HDMI-A-1
[538.040590] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.254s)
[538.041337] Subtest wait-forked-busy: SUCCESS (2.541s)
[538.204148] [122/131] (492s left) kms_content_protection (legacy)
[538.294895] Starting subtest: legacy
[538.308348] Subtest legacy: SKIP (0.012s)
[538.430214] [123/131] (492s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[538.525213] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[538.526633] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[538.637391] [124/131] (492s left) gem_mmap_gtt (cpuset-medium-copy)
[538.671638] Starting subtest: cpuset-medium-copy
[544.903567] Subtest cpuset-medium-copy: SUCCESS (6.229s)
[545.028853] [125/131] (485s left) prime_vgem (fence-wait)
[545.138218] Starting subtest: fence-wait
[545.138961] Starting dynamic subtest: rcs0
[546.191246] Dynamic subtest rcs0: SUCCESS (1.043s)
[546.203887] Starting dynamic subtest: bcs0
[547.213417] Dynamic subtest bcs0: SUCCESS (1.020s)
[547.225893] Starting dynamic subtest: vcs0
[548.236569] Dynamic subtest vcs0: SUCCESS (1.020s)
[548.248785] Starting dynamic subtest: vcs1
[549.260270] Dynamic subtest vcs1: SUCCESS (1.021s)
[549.272419] Starting dynamic subtest: vecs0
[550.285700] Dynamic subtest vecs0: SUCCESS (1.022s)
[550.286736] Subtest fence-wait: SUCCESS (5.139s)
[550.421664] [126/131] (480s left) kms_addfb_basic (bo-too-small)
[550.513002] Starting subtest: bo-too-small
[550.513735] Subtest bo-too-small: SUCCESS (0.000s)
[550.629735] [127/131] (480s left) kms_plane_scaling (planes-scaler-unity-scaling)
[550.714937] Starting subtest: planes-scaler-unity-scaling
[550.715634] Starting dynamic subtest: pipe-A
[550.775401] Dynamic subtest pipe-A: SUCCESS (0.061s)
[550.787894] Starting dynamic subtest: pipe-B
[550.909284] Dynamic subtest pipe-B: SUCCESS (0.133s)
[550.919240] Starting dynamic subtest: pipe-C
[551.033781] Dynamic subtest pipe-C: SUCCESS (0.124s)
[551.043769] Starting dynamic subtest: pipe-D
[551.159985] Dynamic subtest pipe-D: SUCCESS (0.125s)
[551.160739] Subtest planes-scaler-unity-scaling: SUCCESS (0.446s)
[551.343275] [128/131] (479s left) gem_exec_params (invalid-flag)
[551.379692] Starting subtest: invalid-flag
[551.380379] Subtest invalid-flag: SUCCESS (0.000s)
[551.485506] [129/131] (479s left) kms_async_flips (crc-atomic)
[551.571400] Starting subtest: crc-atomic
[551.697346] Starting dynamic subtest: pipe-A-HDMI-A-1
[553.847260] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.141s)
[553.976012] Starting dynamic subtest: pipe-B-HDMI-A-1
[556.088958] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.112s)
[556.201976] Starting dynamic subtest: pipe-C-HDMI-A-1
[558.327253] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (2.124s)
[558.443262] Starting dynamic subtest: pipe-D-HDMI-A-1
[560.567269] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.123s)
[560.568107] Subtest crc-atomic: SUCCESS (8.987s)
[560.801945] [130/131] (470s left) kms_rotation_crc (sprite-rotation-90-pos-100-0)
[560.889827] Starting subtest: sprite-rotation-90-pos-100-0
[565.690220] Subtest sprite-rotation-90-pos-100-0: SUCCESS (4.799s)
[565.921902] [131/131] (465s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-blt)
[566.016294] Starting subtest: psr-2p-primscrn-pri-indfb-draw-blt
[566.017718] Subtest psr-2p-primscrn-pri-indfb-draw-blt: SKIP (0.000s)
[566.145835] Closing watchdogs
results: parsing output: 0/ for test: syncobj_timeline
results: parsing output: 1/ for test: kms_flip_scaled_crc
results: parsing output: 2/ for test: sw_sync
results: parsing output: 3/ for test: kms_frontbuffer_tracking
results: parsing output: 4/ for test: api_intel_bb
results: parsing output: 5/ for test: kms_plane_cursor
results: parsing output: 6/ for test: syncobj_wait
results: parsing output: 7/ for test: kms_frontbuffer_tracking
results: parsing output: 8/ for test: perf_pmu
results: parsing output: 9/ for test: kms_frontbuffer_tracking
results: parsing output: 10/ for test: kms_ccs
results: parsing output: 11/ for test: kms_chamelium_hpd
results: parsing output: 12/ for test: kms_frontbuffer_tracking
results: parsing output: 13/ for test: prime_udl
results: parsing output: 14/ for test: kms_frontbuffer_tracking
results: parsing output: 15/ for test: kms_ccs
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: gem_mmap_gtt
results: parsing output: 19/ for test: gem_exec_schedule
results: parsing output: 20/ for test: gen7_exec_parse
results: parsing output: 21/ for test: gem_exec_reloc
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: syncobj_basic
results: parsing output: 24/ for test: kms_addfb_basic
results: parsing output: 25/ for test: kms_sequence
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: syncobj_timeline
results: parsing output: 28/ for test: i915_selftest
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: kms_cursor_crc
results: parsing output: 31/ for test: i915_pm_freq_api
results: parsing output: 32/ for test: api_intel_allocator
results: parsing output: 33/ for test: gem_ctx_persistence
results: parsing output: 34/ for test: gem_eio
results: parsing output: 35/ for test: i915_pm_freq_mult
results: parsing output: 36/ for test: gem_fenced_exec_thrash
results: parsing output: 37/ for test: gem_exec_balancer
results: parsing output: 38/ for test: gem_ccs
results: parsing output: 39/ for test: kms_lease
results: parsing output: 40/ for test: kms_pm_rpm
results: parsing output: 41/ for test: gem_exec_whisper
results: parsing output: 42/ for test: syncobj_wait
results: parsing output: 43/ for test: kms_flip
results: parsing output: 44/ for test: gem_exec_alignment
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: dumb_buffer
results: parsing output: 48/ for test: gem_ctx_param
results: parsing output: 49/ for test: syncobj_timeline
results: parsing output: 50/ for test: gem_pxp
results: parsing output: 51/ for test: sw_sync
results: parsing output: 52/ for test: kms_psr2_sf
results: parsing output: 53/ for test: gem_userptr_blits
results: parsing output: 54/ for test: kms_frontbuffer_tracking
results: parsing output: 55/ for test: kms_big_fb
results: parsing output: 56/ for test: perf_pmu
results: parsing output: 57/ for test: gem_exec_params
results: parsing output: 58/ for test: kms_cursor_crc
results: parsing output: 59/ for test: kms_psr
results: parsing output: 60/ for test: kms_big_fb
results: parsing output: 61/ for test: kms_cursor_crc
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_frontbuffer_tracking
results: parsing output: 64/ for test: kms_frontbuffer_tracking
results: parsing output: 65/ for test: gem_sync
results: parsing output: 66/ for test: gem_spin_batch
results: parsing output: 67/ for test: syncobj_wait
results: parsing output: 68/ for test: gem_mmap_gtt
results: parsing output: 69/ for test: gem_mmap_gtt
results: parsing output: 70/ for test: gem_exec_alignment
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: kms_dirtyfb
results: parsing output: 73/ for test: gem_exec_fence
results: parsing output: 74/ for test: kms_hdr
results: parsing output: 75/ for test: sysfs_preempt_timeout
results: parsing output: 76/ for test: kms_psr
results: parsing output: 77/ for test: kms_psr2_sf
results: parsing output: 78/ for test: kms_psr
results: parsing output: 79/ for test: kms_flip_scaled_crc
results: parsing output: 80/ for test: kms_busy
results: parsing output: 81/ for test: gem_pwrite
results: parsing output: 82/ for test: gem_caching
results: parsing output: 83/ for test: perf_pmu
results: parsing output: 84/ for test: gen9_exec_parse
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: gem_lmem_swapping
results: parsing output: 87/ for test: kms_big_fb
results: parsing output: 88/ for test: gem_ctx_bad_destroy
results: parsing output: 89/ for test: syncobj_eventfd
results: parsing output: 90/ for test: kms_async_flips
results: parsing output: 91/ for test: gem_ctx_persistence
results: parsing output: 92/ for test: gem_exec_parallel
results: parsing output: 93/ for test: kms_cdclk
results: parsing output: 94/ for test: kms_ccs
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: gem_close_race
results: parsing output: 97/ for test: gem_render_copy
results: parsing output: 98/ for test: kms_frontbuffer_tracking
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: gem_exec_fence
results: parsing output: 101/ for test: kms_flip
results: parsing output: 102/ for test: kms_flip
results: parsing output: 103/ for test: gem_exec_schedule
results: parsing output: 104/ for test: kms_psr
results: parsing output: 105/ for test: kms_big_fb
results: parsing output: 106/ for test: kms_draw_crc
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_plane
results: parsing output: 109/ for test: kms_chamelium_frames
results: parsing output: 110/ for test: kms_frontbuffer_tracking
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: syncobj_timeline
results: parsing output: 113/ for test: kms_properties
results: parsing output: 114/ for test: gem_exec_suspend
results: parsing output: 115/ for test: kms_flip_scaled_crc
results: parsing output: 116/ for test: kms_psr
results: parsing output: 117/ for test: kms_frontbuffer_tracking
results: parsing output: 118/ for test: kms_joiner
results: parsing output: 119/ for test: kms_prop_blob
results: parsing output: 120/ for test: kms_vblank
results: parsing output: 121/ for test: kms_content_protection
results: parsing output: 122/ for test: kms_big_fb
results: parsing output: 123/ for test: gem_mmap_gtt
results: parsing output: 124/ for test: prime_vgem
results: parsing output: 125/ for test: kms_addfb_basic
results: parsing output: 126/ for test: kms_plane_scaling
results: parsing output: 127/ for test: gem_exec_params
results: parsing output: 128/ for test: kms_async_flips
results: parsing output: 129/ for test: kms_rotation_crc
results: parsing output: 130/ for test: kms_frontbuffer_tracking
Done.