[56.039189] Initializing watchdogs
[56.039236]   /dev/watchdog0
[56.052784] [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]
[56.057167] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.059372] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.062620] [001/132] (960s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling)
[56.186665] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling
[56.188857] Starting dynamic subtest: pipe-A-default-mode
[56.471204] Dynamic subtest pipe-A-default-mode: SKIP (0.284s)
[56.475104] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.285s)
[57.300194] [002/132] (959s left) kms_rmfb (rmfb-ioctl)
[57.402453] Starting subtest: rmfb-ioctl
[57.404616] Starting dynamic subtest: pipe-A-eDP-1
[57.506660] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s)
[57.513626] Starting dynamic subtest: pipe-B-eDP-1
[58.648864] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.141s)
[58.655640] Starting dynamic subtest: pipe-C-eDP-1
[59.774384] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.126s)
[59.783300] Starting dynamic subtest: pipe-D-eDP-1
[60.908716] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.134s)
[60.910984] Subtest rmfb-ioctl: SUCCESS (3.512s)
[62.152136] [003/132] (954s left) gen9_exec_parse (valid-registers)
[62.202859] Subtest valid-registers: SKIP (0.000s)
[62.267050] [004/132] (954s left) gem_ctx_param (invalid-param-get)
[62.326908] Starting subtest: invalid-param-get
[62.329330] Subtest invalid-param-get: SUCCESS (0.002s)
[62.458180] [005/132] (954s left) kms_vrr (lobf)
[62.555664] Starting subtest: lobf
[62.560226] Subtest lobf: SKIP (0.000s)
[62.634785] [006/132] (954s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt)
[62.733848] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt
[62.738068] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[62.852137] [007/132] (953s left) kms_flip_event_leak (basic)
[62.951075] Starting subtest: basic
[62.953391] Starting dynamic subtest: pipe-A-eDP-1
[63.368739] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.418s)
[63.377134] Starting dynamic subtest: pipe-B-eDP-1
[64.459713] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.090s)
[64.466484] Starting dynamic subtest: pipe-C-eDP-1
[65.572090] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.113s)
[65.579066] Starting dynamic subtest: pipe-D-eDP-1
[66.712074] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.141s)
[66.714301] Subtest basic: SUCCESS (3.766s)
[67.595257] [008/132] (949s left) gen9_exec_parse (bb-chained)
[67.659237] Subtest bb-chained: SKIP (0.000s)
[67.735384] [009/132] (949s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-pwrite)
[67.841611] Starting subtest: psr-2p-primscrn-cur-indfb-draw-pwrite
[67.846029] Subtest psr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[67.949201] [010/132] (948s left) i915_pm_rpm (system-suspend)
[70.090614] Starting subtest: system-suspend
[87.758637] Subtest system-suspend: SUCCESS (3.620s)
[88.146742] [011/132] (928s left) gem_spin_batch (legacy)
[88.212697] Starting subtest: legacy
[88.215324] Starting dynamic subtest: default
[91.449989] Dynamic subtest default: SUCCESS (3.240s)
[91.460708] Starting dynamic subtest: render
[94.679409] Dynamic subtest render: SUCCESS (3.234s)
[94.690405] Starting dynamic subtest: bsd
[97.915180] Dynamic subtest bsd: SUCCESS (3.238s)
[97.925943] Starting dynamic subtest: bsd1
[101.148337] Dynamic subtest bsd1: SUCCESS (3.234s)
[101.158680] Starting dynamic subtest: bsd2
[104.382317] Dynamic subtest bsd2: SUCCESS (3.235s)
[104.391704] Starting dynamic subtest: blt
[107.615640] Dynamic subtest blt: SUCCESS (3.234s)
[107.624184] Starting dynamic subtest: vebox
[110.850213] Dynamic subtest vebox: SUCCESS (3.234s)
[110.852942] Subtest legacy: SUCCESS (22.659s)
[111.046438] [012/132] (905s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions)
[111.178068] Starting subtest: flip-vs-cursor-atomic-transitions
[118.616693] Subtest flip-vs-cursor-atomic-transitions: SUCCESS (7.438s)
[119.434593] [013/132] (897s left) syncobj_timeline (multi-wait-available-submitted)
[119.497907] Starting subtest: multi-wait-available-submitted
[119.500742] Subtest multi-wait-available-submitted: SUCCESS (0.000s)
[119.619921] [014/132] (897s left) gem_ctx_param (invalid-get-no-zeromap)
[119.669927] Starting subtest: invalid-get-no-zeromap
[119.672937] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[119.774176] [015/132] (897s left) kms_atomic (plane-overlay-legacy)
[119.867658] Starting subtest: plane-overlay-legacy
[119.870171] Starting dynamic subtest: pipe-A-eDP-1
[120.280372] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.409s)
[120.282898] Subtest plane-overlay-legacy: SUCCESS (0.410s)
[121.200777] [016/132] (895s left) kms_pm_rpm (modeset-lpsp-stress)
[123.132937] Starting subtest: modeset-lpsp-stress
[139.022175] Subtest modeset-lpsp-stress: SUCCESS (15.890s)
[139.120346] [017/132] (878s left) kms_color (deep-color)
[139.214679] Starting subtest: deep-color
[140.247431] Starting dynamic subtest: pipe-A-eDP-1-gamma
[140.954488] Dynamic subtest pipe-A-eDP-1-gamma: SUCCESS (0.705s)
[140.963836] Starting dynamic subtest: pipe-A-eDP-1-degamma
[142.442216] Dynamic subtest pipe-A-eDP-1-degamma: SUCCESS (1.488s)
[142.450754] Starting dynamic subtest: pipe-A-eDP-1-ctm
[143.861909] Dynamic subtest pipe-A-eDP-1-ctm: SUCCESS (1.420s)
[144.651937] Starting dynamic subtest: pipe-B-eDP-1-gamma
[145.353529] Dynamic subtest pipe-B-eDP-1-gamma: SUCCESS (0.707s)
[145.361906] Starting dynamic subtest: pipe-B-eDP-1-degamma
[146.862688] Dynamic subtest pipe-B-eDP-1-degamma: SUCCESS (1.508s)
[146.872023] Starting dynamic subtest: pipe-B-eDP-1-ctm
[148.274821] Dynamic subtest pipe-B-eDP-1-ctm: SUCCESS (1.413s)
[149.044773] Starting dynamic subtest: pipe-C-eDP-1-gamma
[149.746493] Dynamic subtest pipe-C-eDP-1-gamma: SUCCESS (0.706s)
[149.755920] Starting dynamic subtest: pipe-C-eDP-1-degamma
[151.227521] Dynamic subtest pipe-C-eDP-1-degamma: SUCCESS (1.480s)
[151.236439] Starting dynamic subtest: pipe-C-eDP-1-ctm
[152.630541] Dynamic subtest pipe-C-eDP-1-ctm: SUCCESS (1.405s)
[153.441882] Starting dynamic subtest: pipe-D-eDP-1-gamma
[154.122589] Dynamic subtest pipe-D-eDP-1-gamma: SUCCESS (0.684s)
[154.131597] Starting dynamic subtest: pipe-D-eDP-1-degamma
[155.501624] Dynamic subtest pipe-D-eDP-1-degamma: SUCCESS (1.380s)
[155.512163] Starting dynamic subtest: pipe-D-eDP-1-ctm
[156.909552] Dynamic subtest pipe-D-eDP-1-ctm: SUCCESS (1.409s)
[156.912134] Subtest deep-color: SUCCESS (17.699s)
[157.785096] [018/132] (859s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[157.893397] Starting subtest: addfb25-yf-tiled-legacy
[157.895752] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[158.006906] [019/132] (859s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-rc-ccs)
[158.108655] Starting subtest: missing-ccs-buffer-y-tiled-gen12-rc-ccs
[158.111424] Starting dynamic subtest: pipe-A-eDP-1
[158.137683] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[158.146585] Starting dynamic subtest: pipe-B-eDP-1
[158.172142] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[158.179424] Starting dynamic subtest: pipe-C-eDP-1
[158.205481] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[158.215714] Starting dynamic subtest: pipe-D-eDP-1
[158.241668] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[158.246816] Subtest missing-ccs-buffer-y-tiled-gen12-rc-ccs: SKIP (0.004s)
[160.354106] [020/132] (856s left) kms_joiner (invalid-modeset-ultra-joiner)
[160.463343] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s)
[160.529148] [021/132] (856s left) gem_mmap_gtt (cpuset-basic-small-copy)
[160.599591] Subtest cpuset-basic-small-copy: SKIP (0.000s)
[160.666276] [022/132] (856s left) kms_chamelium_hpd (hdmi-hpd)
[161.051653] Subtest hdmi-hpd: SKIP (0.000s)
[161.864184] [023/132] (855s left) kms_ccs (bad-rotation-90-4-tiled-dg2-mc-ccs)
[161.960723] Starting subtest: bad-rotation-90-4-tiled-dg2-mc-ccs
[161.963488] Starting dynamic subtest: pipe-A-eDP-1
[161.987480] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[161.996292] Starting dynamic subtest: pipe-B-eDP-1
[162.021356] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[162.029672] Starting dynamic subtest: pipe-C-eDP-1
[162.055757] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[162.065523] Starting dynamic subtest: pipe-D-eDP-1
[162.091081] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[162.096282] Subtest bad-rotation-90-4-tiled-dg2-mc-ccs: SKIP (0.004s)
[164.249340] [024/132] (853s left) kms_cursor_crc (cursor-rapid-movement-512x170)
[164.533511] Starting subtest: cursor-rapid-movement-512x170
[164.538161] Subtest cursor-rapid-movement-512x170: SKIP (0.001s)
[164.685148] [025/132] (852s left) gem_exec_basic (basic)
[164.746631] Starting subtest: basic
[164.749320] Starting dynamic subtest: rcs0-smem
[164.751576] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[164.759790] Starting dynamic subtest: bcs0-smem
[164.762341] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[164.770335] Starting dynamic subtest: vcs0-smem
[164.772726] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[164.780362] Starting dynamic subtest: vcs1-smem
[164.782788] Dynamic subtest vcs1-smem: SUCCESS (0.003s)
[164.790649] Starting dynamic subtest: vecs0-smem
[164.793236] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[164.801063] Starting dynamic subtest: ccs0-smem
[164.803751] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[164.806659] Subtest basic: SUCCESS (0.019s)
[166.010802] [026/132] (851s left) kms_cursor_legacy (torture-bo)
[166.125751] Starting subtest: torture-bo
[166.128541] Starting dynamic subtest: pipe-A
[171.738938] Dynamic subtest pipe-A: SUCCESS (5.614s)
[171.749509] Starting dynamic subtest: pipe-B
[177.830911] Dynamic subtest pipe-B: SUCCESS (6.090s)
[177.840948] Starting dynamic subtest: pipe-C
[184.303573] Dynamic subtest pipe-C: SUCCESS (6.470s)
[184.315836] Starting dynamic subtest: pipe-D
[190.859496] Dynamic subtest pipe-D: SUCCESS (6.553s)
[190.870613] Starting dynamic subtest: all-pipes
[196.852960] Dynamic subtest all-pipes: SUCCESS (5.991s)
[196.855643] Subtest torture-bo: SUCCESS (30.726s)
[197.036180] [027/132] (820s left) gem_ctx_bad_destroy (invalid-pad)
[197.090146] Starting subtest: invalid-pad
[197.092747] Subtest invalid-pad: SUCCESS (0.000s)
[197.188491] [028/132] (820s left) kms_psr (psr-no-drrs)
[197.284342] Starting subtest: psr-no-drrs
[197.286618] Starting dynamic subtest: eDP-1
[198.905726] Dynamic subtest eDP-1: SUCCESS (1.618s)
[198.908242] Subtest psr-no-drrs: SUCCESS (1.619s)
[199.804202] [029/132] (817s left) gem_eio (suspend)
[200.030940] Starting subtest: suspend
[211.931751] Subtest suspend: SUCCESS (11.898s)
[212.099076] [030/132] (805s left) kms_cursor_legacy (flip-vs-cursor-crc-legacy)
[212.228686] Starting subtest: flip-vs-cursor-crc-legacy
[212.866849] Subtest flip-vs-cursor-crc-legacy: SUCCESS (0.640s)
[213.703370] [031/132] (804s left) syncobj_wait (reset-during-wait-for-submit)
[213.756939] Starting subtest: reset-during-wait-for-submit
[213.858252] Subtest reset-during-wait-for-submit: SUCCESS (0.103s)
[213.947563] [032/132] (803s left) kms_sharpness_filter (filter-toggle)
[214.031588] Starting subtest: filter-toggle
[214.046643] Subtest filter-toggle: SKIP (0.001s)
[214.112676] [033/132] (803s left) kms_big_fb (4-tiled-64bpp-rotate-180)
[214.220777] Starting subtest: 4-tiled-64bpp-rotate-180
[215.766809] Subtest 4-tiled-64bpp-rotate-180: SUCCESS (1.546s)
[215.975741] [034/132] (801s left) kms_prop_blob (blob-multiple)
[216.038644] Starting subtest: blob-multiple
[216.041208] Subtest blob-multiple: SUCCESS (0.002s)
[216.148197] [035/132] (801s left) kms_psr (pr-cursor-mmap-gtt)
[216.242507] Starting subtest: pr-cursor-mmap-gtt
[216.246700] Subtest pr-cursor-mmap-gtt: SKIP (0.000s)
[216.333601] [036/132] (801s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size)
[216.448050] Starting subtest: cursorB-vs-flipB-varying-size
[216.452186] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s)
[216.602067] [037/132] (801s left) gem_watchdog (default-physical)
[216.668560] Starting subtest: default-physical
[218.433751] Subtest default-physical: SUCCESS (1.774s)
[218.537238] [038/132] (799s left) kms_psr (fbc-psr2-primary-page-flip)
[218.623916] Starting subtest: fbc-psr2-primary-page-flip
[218.626678] Starting dynamic subtest: eDP-1
[218.631613] Dynamic subtest eDP-1: SKIP (0.000s)
[218.636679] Subtest fbc-psr2-primary-page-flip: SKIP (0.001s)
[218.720267] [039/132] (799s left) gem_exec_reloc (basic-write-wc-active)
[218.780936] Subtest basic-write-wc-active: SKIP (0.000s)
[218.858734] [040/132] (799s left) kms_big_fb (x-tiled-8bpp-rotate-180)
[218.959555] Starting subtest: x-tiled-8bpp-rotate-180
[220.230962] Subtest x-tiled-8bpp-rotate-180: SUCCESS (1.271s)
[220.399167] [041/132] (797s left) kms_psr2_sf (fbc-pr-overlay-plane-move-continuous-exceed-fully-sf)
[225.481894] Starting subtest: fbc-pr-overlay-plane-move-continuous-exceed-fully-sf
[225.487414] Subtest fbc-pr-overlay-plane-move-continuous-exceed-fully-sf: SKIP (0.002s)
[226.353243] [042/132] (791s left) gem_exec_reloc (basic-write-cpu)
[226.409611] Subtest basic-write-cpu: SKIP (0.000s)
[226.477036] [043/132] (791s left) kms_plane_alpha_blend (coverage-vs-premult-vs-constant)
[226.564916] Starting subtest: coverage-vs-premult-vs-constant
[226.862562] Starting dynamic subtest: pipe-A-eDP-1
[227.403196] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.540s)
[227.413024] Starting dynamic subtest: pipe-D-eDP-1
[228.750624] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.345s)
[228.753129] Subtest coverage-vs-premult-vs-constant: SUCCESS (2.187s)
[229.600240] [044/132] (788s left) gem_eio (wait-wedge-immediate)
[229.821442] Starting subtest: wait-wedge-immediate
[231.028264] Subtest wait-wedge-immediate: SUCCESS (1.207s)
[231.171890] [045/132] (787s left) perf_pmu (init-busy)
[231.210077] Starting subtest: init-busy
[231.212358] Starting dynamic subtest: rcs0
[231.214593] Dynamic subtest rcs0: SUCCESS (0.002s)
[231.222937] Starting dynamic subtest: bcs0
[231.225705] Dynamic subtest bcs0: SUCCESS (0.000s)
[231.234027] Starting dynamic subtest: vcs0
[231.236664] Dynamic subtest vcs0: SUCCESS (0.000s)
[231.244854] Starting dynamic subtest: vcs1
[231.247507] Dynamic subtest vcs1: SUCCESS (0.000s)
[231.255603] Starting dynamic subtest: vecs0
[231.258196] Dynamic subtest vecs0: SUCCESS (0.000s)
[231.266746] Starting dynamic subtest: ccs0
[231.269194] Dynamic subtest ccs0: SUCCESS (0.000s)
[231.271396] Subtest init-busy: SUCCESS (0.007s)
[231.328897] [046/132] (787s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render)
[231.418351] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render
[231.423232] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s)
[231.530043] [047/132] (786s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc)
[231.636245] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc
[231.640909] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[231.748979] [048/132] (786s left) kms_chamelium_audio (hdmi-audio-edid)
[232.139886] Subtest hdmi-audio-edid: SKIP (0.000s)
[232.899238] [049/132] (785s left) gem_exec_schedule (smoketest)
[233.070645] Starting subtest: smoketest
[233.073338] Starting dynamic subtest: rcs0
[238.646814] Dynamic subtest rcs0: SUCCESS (5.513s)
[238.656482] Starting dynamic subtest: bcs0
[244.188266] Dynamic subtest bcs0: SUCCESS (5.539s)
[244.199712] Starting dynamic subtest: vcs0
[249.710241] Dynamic subtest vcs0: SUCCESS (5.525s)
[249.725357] Starting dynamic subtest: vcs1
[255.249663] Dynamic subtest vcs1: SUCCESS (5.535s)
[255.259586] Starting dynamic subtest: vecs0
[260.762169] Dynamic subtest vecs0: SUCCESS (5.526s)
[260.777914] Starting dynamic subtest: ccs0
[266.306700] Dynamic subtest ccs0: SUCCESS (5.539s)
[266.309167] Subtest smoketest: SUCCESS (33.183s)
[266.512124] [050/132] (752s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs)
[266.610640] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs
[266.613121] Starting dynamic subtest: pipe-A-eDP-1
[266.636317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[266.646794] Starting dynamic subtest: pipe-B-eDP-1
[266.670273] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[266.678724] Starting dynamic subtest: pipe-C-eDP-1
[266.702051] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[266.710519] Starting dynamic subtest: pipe-D-eDP-1
[266.733738] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[266.736458] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs: SUCCESS (0.007s)
[268.793179] [051/132] (749s left) gem_exec_schedule (u-submit-golden-slice)
[268.869355] Starting subtest: u-submit-golden-slice
[268.871935] Starting dynamic subtest: rcs0
[268.893721] Dynamic subtest rcs0: SUCCESS (0.036s)
[268.902696] Starting dynamic subtest: bcs0
[268.927433] Dynamic subtest bcs0: SUCCESS (0.033s)
[268.935944] Starting dynamic subtest: vcs0
[268.960779] Dynamic subtest vcs0: SUCCESS (0.033s)
[268.970532] Starting dynamic subtest: vcs1
[268.994924] Dynamic subtest vcs1: SUCCESS (0.034s)
[269.004037] Starting dynamic subtest: vecs0
[269.030610] Dynamic subtest vecs0: SUCCESS (0.034s)
[269.044579] Starting dynamic subtest: ccs0
[269.069300] Dynamic subtest ccs0: SUCCESS (0.036s)
[269.071807] Subtest u-submit-golden-slice: SUCCESS (0.213s)
[270.038071] [052/132] (748s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc)
[270.134924] Starting subtest: psr-rgb565-draw-mmap-wc
[276.836832] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.705s)
[276.959088] [053/132] (741s left) gem_pread (snoop)
[277.014188] Subtest snoop: SKIP (0.000s)
[277.085275] [054/132] (741s left) syncobj_wait (wait-for-submit-complex)
[277.136599] Starting subtest: wait-for-submit-complex
[277.195898] Subtest wait-for-submit-complex: SUCCESS (0.062s)
[277.296693] [055/132] (741s left) kms_flip (blocking-wf_vblank)
[277.388429] Starting subtest: blocking-wf_vblank
[277.390803] Starting dynamic subtest: A-eDP1
[286.354775] Dynamic subtest A-eDP1: SUCCESS (8.968s)
[286.363754] Starting dynamic subtest: B-eDP1
[295.284360] Dynamic subtest B-eDP1: SUCCESS (8.929s)
[295.295454] Starting dynamic subtest: C-eDP1
[304.200335] Dynamic subtest C-eDP1: SUCCESS (8.915s)
[304.209207] Starting dynamic subtest: D-eDP1
[313.125705] Dynamic subtest D-eDP1: SUCCESS (8.927s)
[313.131374] Subtest blocking-wf_vblank: SUCCESS (35.748s)
[314.365378] [056/132] (704s left) kms_fbcon_fbt (psr-suspend)
[314.409801] Starting subtest: psr-suspend
[363.957860] Subtest psr-suspend: SUCCESS (19.651s)
[364.049374] [057/132] (654s left) sysfs_timeslice_duration (idempotent)
[364.112034] Starting subtest: idempotent
[364.114467] Starting dynamic subtest: vecs0
[364.116850] Dynamic subtest vecs0: SUCCESS (0.000s)
[364.126980] Starting dynamic subtest: ccs0
[364.128932] Dynamic subtest ccs0: SUCCESS (0.000s)
[364.137037] Starting dynamic subtest: vcs0
[364.138975] Dynamic subtest vcs0: SUCCESS (0.000s)
[364.146926] Starting dynamic subtest: bcs0
[364.148927] Dynamic subtest bcs0: SUCCESS (0.000s)
[364.156510] Starting dynamic subtest: rcs0
[364.158482] Dynamic subtest rcs0: SUCCESS (0.000s)
[364.166457] Starting dynamic subtest: vcs1
[364.168648] Dynamic subtest vcs1: SUCCESS (0.000s)
[364.170902] Subtest idempotent: SUCCESS (0.006s)
[364.226214] [058/132] (654s left) perf (non-system-wide-paranoid)
[364.346741] Starting subtest: non-system-wide-paranoid
[364.371256] Subtest non-system-wide-paranoid: SUCCESS (0.027s)
[364.415304] [059/132] (654s left) gem_userptr_blits (readonly-unsync)
[364.481015] Subtest readonly-unsync: SKIP (0.000s)
[364.640669] [060/132] (654s left) kms_vblank (query-forked-hang)
[364.734166] Starting subtest: query-forked-hang
[364.736405] Starting dynamic subtest: pipe-A-eDP-1
[391.650960] Dynamic subtest pipe-A-eDP-1: SUCCESS (26.932s)
[391.665003] Starting dynamic subtest: pipe-D-eDP-1
[416.680535] Dynamic subtest pipe-D-eDP-1: SUCCESS (25.028s)
[416.682478] Subtest query-forked-hang: SUCCESS (51.965s)
[417.484319] [061/132] (601s left) kms_cursor_legacy (short-flip-before-cursor-atomic-transitions-varying-size)
[417.598159] Starting subtest: short-flip-before-cursor-atomic-transitions-varying-size
[418.563832] Subtest short-flip-before-cursor-atomic-transitions-varying-size: SUCCESS (0.965s)
[419.419085] [062/132] (599s left) dmabuf_sync_file (export-wait-after-attach)
[419.524188] Starting subtest: export-wait-after-attach
[419.526581] Subtest export-wait-after-attach: SUCCESS (0.001s)
[419.588493] [FACT dmabuf_sync_file (export-wait-after-attach)] new: kernel.kmod_is_loaded.vgem: true
[419.592258] [063/132] (599s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt)
[419.681541] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt
[419.685805] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s)
[419.773204] [064/132] (599s left) kms_scaling_modes (scaling-mode-none)
[419.862408] Starting subtest: scaling-mode-none
[419.864580] Starting dynamic subtest: pipe-A-eDP-1
[419.960485] Dynamic subtest pipe-A-eDP-1: SKIP (0.095s)
[419.971355] Starting dynamic subtest: pipe-B-eDP-1
[419.995658] Dynamic subtest pipe-B-eDP-1: SKIP (0.034s)
[420.005838] Starting dynamic subtest: pipe-C-eDP-1
[420.029238] Dynamic subtest pipe-C-eDP-1: SKIP (0.032s)
[420.037752] Starting dynamic subtest: pipe-D-eDP-1
[420.063940] Dynamic subtest pipe-D-eDP-1: SKIP (0.034s)
[420.068281] Subtest scaling-mode-none: SKIP (0.200s)
[420.217173] [065/132] (598s left) gem_ctx_exec (basic-close-race)
[420.276024] Starting subtest: basic-close-race
[426.117553] Subtest basic-close-race: SUCCESS (5.845s)
[426.282995] [066/132] (592s left) kms_chamelium_edid (hdmi-edid-change-during-suspend)
[426.662711] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s)
[427.499849] [067/132] (591s left) gem_pxp (protected-encrypted-src-copy-not-readible)
[427.624711] Starting subtest: protected-encrypted-src-copy-not-readible
[427.732896] Subtest protected-encrypted-src-copy-not-readible: SUCCESS (0.109s)
[427.896645] [068/132] (591s left) gem_userptr_blits (unsync-unmap-cycles)
[427.957999] Subtest unsync-unmap-cycles: SKIP (0.000s)
[428.116922] [069/132] (591s left) i915_pm_rps (thresholds-park)
[428.180872] Starting subtest: thresholds-park
[428.185078] Subtest thresholds-park: SKIP (0.001s)
[428.298762] [070/132] (591s left) gem_workarounds (basic-read)
[428.358898] Starting subtest: basic-read
[428.369987] Subtest basic-read: SUCCESS (0.011s)
[428.484406] [071/132] (590s left) prime_vgem (sync)
[428.577705] Starting subtest: sync
[428.579668] Starting dynamic subtest: rcs0
[428.612522] Dynamic subtest rcs0: SUCCESS (0.036s)
[428.621952] Starting dynamic subtest: bcs0
[428.669279] Dynamic subtest bcs0: SUCCESS (0.056s)
[428.677742] Starting dynamic subtest: vcs0
[428.716191] Dynamic subtest vcs0: SUCCESS (0.046s)
[428.724661] Starting dynamic subtest: vcs1
[428.764612] Dynamic subtest vcs1: SUCCESS (0.048s)
[428.772631] Starting dynamic subtest: vecs0
[428.810526] Dynamic subtest vecs0: SUCCESS (0.045s)
[428.818688] Starting dynamic subtest: ccs0
[428.857520] Dynamic subtest ccs0: SUCCESS (0.046s)
[428.859306] Subtest sync: SUCCESS (0.282s)
[429.029486] [072/132] (590s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[429.131446] Starting subtest: fbc-indfb-scaledprimary
[432.113189] Subtest fbc-indfb-scaledprimary: SUCCESS (2.985s)
[433.333059] [073/132] (586s left) gem_mmap_offset (clear)
[433.390357] Starting subtest: clear
[433.392945] Starting dynamic subtest: smem0
[458.175437] Dynamic subtest smem0: SUCCESS (24.790s)
[458.177849] Subtest clear: SUCCESS (24.790s)
[458.352495] [074/132] (561s left) i915_hangman (gt-engine-hang)
[458.466300] Starting subtest: gt-engine-hang
[458.468539] Starting dynamic subtest: rcs0
[459.828355] Dynamic subtest rcs0: SUCCESS (1.359s)
[459.840774] Starting dynamic subtest: bcs0
[461.875538] Dynamic subtest bcs0: SUCCESS (2.043s)
[461.888482] Starting dynamic subtest: vcs0
[463.860839] Dynamic subtest vcs0: SUCCESS (1.982s)
[463.872439] Starting dynamic subtest: vcs1
[465.843160] Dynamic subtest vcs1: SUCCESS (1.979s)
[465.855400] Starting dynamic subtest: vecs0
[467.827768] Dynamic subtest vecs0: SUCCESS (1.982s)
[467.839939] Starting dynamic subtest: ccs0
[469.811123] Dynamic subtest ccs0: SUCCESS (1.980s)
[469.813917] Subtest gt-engine-hang: SUCCESS (11.340s)
[469.904584] [075/132] (549s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[470.013957] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[470.024640] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[470.166404] [076/132] (549s left) gem_exec_parallel (userptr)
[470.227736] Starting subtest: userptr
[470.229971] Starting dynamic subtest: rcs0
[471.678644] Dynamic subtest rcs0: SUCCESS (1.450s)
[471.690013] Starting dynamic subtest: bcs0
[473.157222] Dynamic subtest bcs0: SUCCESS (1.476s)
[473.169933] Starting dynamic subtest: vcs0
[474.859339] Dynamic subtest vcs0: SUCCESS (1.697s)
[474.871375] Starting dynamic subtest: vcs1
[476.820492] Dynamic subtest vcs1: SUCCESS (1.960s)
[476.832573] Starting dynamic subtest: vecs0
[478.868865] Dynamic subtest vecs0: SUCCESS (2.045s)
[478.882402] Starting dynamic subtest: ccs0
[480.335269] Dynamic subtest ccs0: SUCCESS (1.465s)
[480.337544] Subtest userptr: SUCCESS (10.105s)
[480.536599] [077/132] (539s left) syncobj_timeline (wait-all-for-submit-delayed-submit)
[480.601745] Starting subtest: wait-all-for-submit-delayed-submit
[480.704342] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.103s)
[480.822368] [078/132] (538s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-blt)
[480.916302] Starting subtest: fbcpsr-rgb565-draw-blt
[487.921076] Subtest fbcpsr-rgb565-draw-blt: SUCCESS (7.006s)
[488.090243] [079/132] (531s left) kms_cursor_crc (cursor-sliding-32x32)
[488.233689] Starting subtest: cursor-sliding-32x32
[488.279058] Subtest cursor-sliding-32x32: SKIP (0.041s)
[488.565824] [080/132] (531s left) gem_exec_reloc (basic-gtt-read-active)
[488.626884] Subtest basic-gtt-read-active: SKIP (0.000s)
[488.700625] [081/132] (531s left) prime_busy (hang-wait)
[488.755536] Starting subtest: hang-wait
[488.757830] Starting dynamic subtest: rcs0
[514.351923] Dynamic subtest rcs0: SUCCESS (25.593s)
[514.362834] Starting dynamic subtest: bcs0
[521.507302] Dynamic subtest bcs0: SUCCESS (7.160s)
[521.516371] Starting dynamic subtest: vcs0
[528.480738] Dynamic subtest vcs0: SUCCESS (6.973s)
[528.490887] Starting dynamic subtest: vcs1
[535.456402] Dynamic subtest vcs1: SUCCESS (6.974s)
[535.468031] Starting dynamic subtest: vecs0
[542.497174] Dynamic subtest vecs0: SUCCESS (7.039s)
[542.507860] Starting dynamic subtest: ccs0
[556.401916] Dynamic subtest ccs0: SUCCESS (13.906s)
[556.404872] Subtest hang-wait: SUCCESS (67.654s)
[556.561350] [082/132] (463s left) fbdev (eof)
[556.598152] Starting subtest: eof
[556.600744] Subtest eof: SUCCESS (0.000s)
[556.700243] [083/132] (463s left) kms_frontbuffer_tracking (fbc-tiling-4)
[556.807857] Starting subtest: fbc-tiling-4
[561.028154] Subtest fbc-tiling-4: SUCCESS (4.225s)
[562.213078] [084/132] (457s left) kms_fbcon_fbt (fbc)
[562.279366] Starting subtest: fbc
[568.621618] Subtest fbc: SUCCESS (6.346s)
[569.704342] [085/132] (450s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[569.801008] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[569.805325] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[569.961538] [086/132] (450s left) kms_setmode (invalid-clone-single-crtc-stealing)
[570.011136] Starting subtest: invalid-clone-single-crtc-stealing
[570.017895] Subtest invalid-clone-single-crtc-stealing: SKIP (0.001s)
[570.138331] [087/132] (449s left) gem_mmap_gtt (basic-write-cpu-read-gtt)
[570.187932] Subtest basic-write-cpu-read-gtt: SKIP (0.000s)
[570.253124] [088/132] (449s left) kms_legacy_colorkey (basic)
[570.348923] Starting subtest: basic
[570.351066] Starting dynamic subtest: pipe-A
[570.392668] Dynamic subtest pipe-A: SUCCESS (0.045s)
[570.404374] Starting dynamic subtest: pipe-B
[570.406844] Dynamic subtest pipe-B: SUCCESS (0.000s)
[570.418176] Starting dynamic subtest: pipe-C
[570.420073] Dynamic subtest pipe-C: SUCCESS (0.000s)
[570.428645] Starting dynamic subtest: pipe-D
[570.430572] Dynamic subtest pipe-D: SUCCESS (0.000s)
[570.432486] Subtest basic: SUCCESS (0.049s)
[570.473219] [089/132] (449s left) kms_frontbuffer_tracking (pipe-fbc-rte)
[570.577325] Starting subtest: pipe-fbc-rte
[570.584206] Starting dynamic subtest: pipe-B-eDP-1
[575.999692] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.429s)
[576.007413] Subtest pipe-fbc-rte: SUCCESS (5.431s)
[578.252631] [090/132] (441s left) kms_big_fb (yf-tiled-8bpp-rotate-0)
[578.353054] Starting subtest: yf-tiled-8bpp-rotate-0
[578.357534] Subtest yf-tiled-8bpp-rotate-0: SKIP (0.000s)
[578.477961] [091/132] (441s left) gem_exec_fence (syncobj-channel)
[578.922798] Starting subtest: syncobj-channel
[579.947127] Subtest syncobj-channel: SUCCESS (1.020s)
[580.993020] [092/132] (439s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-mc-ccs)
[581.089870] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-mc-ccs
[581.092141] Starting dynamic subtest: pipe-A-eDP-1
[581.114229] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[581.125325] Starting dynamic subtest: pipe-B-eDP-1
[581.146723] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[581.156238] Starting dynamic subtest: pipe-C-eDP-1
[581.177696] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[581.187620] Starting dynamic subtest: pipe-D-eDP-1
[581.209518] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[581.213908] Subtest crc-primary-rotation-180-y-tiled-gen12-mc-ccs: SKIP (0.006s)
[583.327410] [093/132] (436s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[583.424471] Starting subtest: y-tiled-64bpp-rotate-180
[583.428837] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[583.547671] [094/132] (436s left) gem_render_copy (yf-tiled-to-vebox-x-tiled)
[583.607973] Starting subtest: yf-tiled-to-vebox-x-tiled
[583.612653] Subtest yf-tiled-to-vebox-x-tiled: SKIP (0.000s)
[583.817688] [095/132] (436s left) gem_pwrite_snooped
[583.956701] [096/132] (436s left) syncobj_wait (multi-wait-submitted)
[584.019784] Starting subtest: multi-wait-submitted
[584.129634] Subtest multi-wait-submitted: SUCCESS (0.107s)
[584.201823] [097/132] (436s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-pgflip-blt)
[584.294513] Starting subtest: psr-2p-scndscrn-shrfb-pgflip-blt
[584.298787] Subtest psr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s)
[584.433633] [098/132] (436s left) gem_exec_params (no-blt)
[584.496532] Starting subtest: no-blt
[584.501679] Subtest no-blt: SUCCESS (0.004s)
[584.675970] [099/132] (435s left) kms_psr (pr-primary-page-flip)
[584.770014] Starting subtest: pr-primary-page-flip
[584.774403] Subtest pr-primary-page-flip: SKIP (0.000s)
[584.871458] [100/132] (435s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc)
[584.979456] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc
[584.983341] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[585.094299] [101/132] (435s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[585.185275] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[585.965364] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[586.164395] [102/132] (434s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-cpu)
[586.262649] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-cpu
[586.267088] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[586.396542] [103/132] (434s left) gem_exec_alignment (forked)
[586.458046] Starting subtest: forked
[624.836726] Subtest forked: SUCCESS (38.366s)
[624.941220] [104/132] (395s left) gem_exec_params (invalid-bsd2-flag-on-blt)
[625.037582] Starting subtest: invalid-bsd2-flag-on-blt
[625.039543] Subtest invalid-bsd2-flag-on-blt: SUCCESS (0.000s)
[625.159051] [105/132] (395s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-wc)
[625.269389] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-wc
[625.273639] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s)
[625.402923] [106/132] (395s left) kms_invalid_mode (uint-max-clock)
[625.506816] Starting subtest: uint-max-clock
[625.509186] Starting dynamic subtest: pipe-A-eDP-1
[625.786919] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.282s)
[625.796065] Starting dynamic subtest: pipe-B-eDP-1
[625.798317] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[625.807234] Starting dynamic subtest: pipe-C-eDP-1
[625.809473] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[625.817907] Starting dynamic subtest: pipe-D-eDP-1
[625.819854] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[625.821766] Subtest uint-max-clock: SUCCESS (0.287s)
[626.646494] [107/132] (394s left) kms_psr2_sf (psr2-overlay-plane-move-continuous-exceed-fully-sf)
[631.806349] Starting subtest: psr2-overlay-plane-move-continuous-exceed-fully-sf
[631.808662] Starting dynamic subtest: pipe-A-eDP-1
[648.991130] Dynamic subtest pipe-A-eDP-1: SUCCESS (17.183s)
[649.003152] Starting dynamic subtest: pipe-B-eDP-1
[666.138964] Dynamic subtest pipe-B-eDP-1: SUCCESS (17.146s)
[666.141233] Subtest psr2-overlay-plane-move-continuous-exceed-fully-sf: SUCCESS (34.333s)
[666.961911] [108/132] (353s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted)
[667.019720] Starting subtest: etime-multi-wait-all-for-submit-submitted
[667.129053] Subtest etime-multi-wait-all-for-submit-submitted: SUCCESS (0.107s)
[667.216259] [109/132] (353s left) gem_exec_balancer (full-late-pulse)
[667.281611] Starting subtest: full-late-pulse
[671.707553] Subtest full-late-pulse: SUCCESS (4.427s)
[672.090626] [110/132] (348s left) gem_userptr_blits (coherency-unsync)
[672.150045] Subtest coherency-unsync: SKIP (0.000s)
[672.284634] [111/132] (348s left) syncobj_timeline (multi-wait-for-submit-unsubmitted-signaled)
[672.331544] Starting subtest: multi-wait-for-submit-unsubmitted-signaled
[672.333462] Subtest multi-wait-for-submit-unsubmitted-signaled: SUCCESS (0.000s)
[672.460062] [112/132] (348s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-indfb-draw-mmap-cpu)
[672.555363] Starting subtest: fbc-1p-offscreen-pri-indfb-draw-mmap-cpu
[676.493387] Subtest fbc-1p-offscreen-pri-indfb-draw-mmap-cpu: SUCCESS (3.942s)
[677.657025] [113/132] (343s left) gem_ctx_persistence (many-contexts)
[677.714566] Starting subtest: many-contexts
[715.396982] Subtest many-contexts: SUCCESS (37.685s)
[715.486254] [114/132] (305s left) kms_psr (fbc-pr-sprite-plane-move)
[715.583985] Starting subtest: fbc-pr-sprite-plane-move
[715.588085] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s)
[715.666914] [115/132] (305s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[715.775925] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[716.399882] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.626s)
[716.642798] [116/132] (304s left) core_setmaster_vs_auth
[716.844351] [117/132] (304s left) api_intel_allocator (open-vm)
[716.901185] Starting subtest: open-vm
[716.903736] Subtest open-vm: SUCCESS (0.003s)
[717.066408] [118/132] (304s left) kms_ccs (bad-aux-stride-yf-tiled-ccs)
[717.161035] Starting subtest: bad-aux-stride-yf-tiled-ccs
[717.163364] Starting dynamic subtest: pipe-A-eDP-1
[717.185829] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[717.197005] Starting dynamic subtest: pipe-B-eDP-1
[717.218588] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[717.228269] Starting dynamic subtest: pipe-C-eDP-1
[717.249253] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[717.258488] Starting dynamic subtest: pipe-D-eDP-1
[717.280367] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[717.284748] Subtest bad-aux-stride-yf-tiled-ccs: SKIP (0.004s)
[719.322587] [119/132] (302s left) gem_exec_schedule (preempt)
[719.395371] Starting subtest: preempt
[719.397393] Starting dynamic subtest: rcs0
[719.407014] Dynamic subtest rcs0: SUCCESS (0.020s)
[719.418955] Starting dynamic subtest: bcs0
[719.423592] Dynamic subtest bcs0: SUCCESS (0.016s)
[719.433802] Starting dynamic subtest: vcs0
[719.443475] Dynamic subtest vcs0: SUCCESS (0.020s)
[719.454551] Starting dynamic subtest: vcs1
[719.462424] Dynamic subtest vcs1: SUCCESS (0.018s)
[719.476291] Starting dynamic subtest: vecs0
[719.480830] Dynamic subtest vecs0: SUCCESS (0.017s)
[719.491375] Starting dynamic subtest: ccs0
[719.500675] Dynamic subtest ccs0: SUCCESS (0.019s)
[719.502898] Subtest preempt: SUCCESS (0.115s)
[720.966798] [120/132] (300s left) gem_mmap (pf-nonblock)
[721.022934] Subtest pf-nonblock: SKIP (0.000s)
[721.093047] [121/132] (300s left) api_intel_bb (reset-flags)
[721.150811] Starting subtest: reset-flags
[721.155841] Subtest reset-flags: SUCCESS (0.006s)
[721.307561] [122/132] (300s left) kms_draw_crc (draw-method-mmap-wc)
[721.409695] Starting subtest: draw-method-mmap-wc
[721.411876] Starting dynamic subtest: xrgb8888-untiled
[721.663972] Dynamic subtest xrgb8888-untiled: SUCCESS (0.256s)
[721.674221] Starting dynamic subtest: rgb565-untiled
[721.885981] Dynamic subtest rgb565-untiled: SUCCESS (0.220s)
[721.896540] Starting dynamic subtest: xrgb2101010-untiled
[722.107773] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.220s)
[722.118317] Starting dynamic subtest: xbgr16161616f-untiled
[722.319141] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.210s)
[722.329891] Starting dynamic subtest: xrgb8888-xtiled
[722.463297] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.144s)
[722.472558] Starting dynamic subtest: rgb565-xtiled
[722.596511] Dynamic subtest rgb565-xtiled: SUCCESS (0.132s)
[722.606696] Starting dynamic subtest: xrgb2101010-xtiled
[722.730441] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s)
[722.746086] Starting dynamic subtest: xbgr16161616f-xtiled
[722.863360] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.132s)
[722.875313] Starting dynamic subtest: xrgb8888-4tiled
[723.029931] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.165s)
[723.040009] Starting dynamic subtest: rgb565-4tiled
[723.163320] Dynamic subtest rgb565-4tiled: SUCCESS (0.133s)
[723.175132] Starting dynamic subtest: xrgb2101010-4tiled
[723.308391] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.144s)
[723.318593] Starting dynamic subtest: xbgr16161616f-4tiled
[723.474149] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.165s)
[723.476133] Subtest draw-method-mmap-wc: SUCCESS (2.069s)
[723.616707] [123/132] (297s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[723.704436] Starting subtest: plane-upscale-20x20-with-pixel-format
[723.706367] Starting dynamic subtest: pipe-A
[724.753034] Dynamic subtest pipe-A: SUCCESS (1.050s)
[724.764844] Starting dynamic subtest: pipe-B
[726.914339] Dynamic subtest pipe-B: SUCCESS (2.161s)
[726.923502] Starting dynamic subtest: pipe-C
[728.114887] Dynamic subtest pipe-C: SUCCESS (1.200s)
[728.127798] Starting dynamic subtest: pipe-D
[729.258369] Dynamic subtest pipe-D: SUCCESS (1.143s)
[729.260700] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.556s)
[730.461241] [124/132] (291s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-render)
[730.569883] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-render
[730.574226] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-render: SKIP (0.000s)
[730.686071] [125/132] (290s left) syncobj_timeline (host-signal-points)
[730.744798] Starting subtest: host-signal-points
[730.749656] Subtest host-signal-points: SUCCESS (0.004s)
[730.881845] [126/132] (290s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers)
[730.970179] Starting subtest: plane-scaler-unity-scaling-with-modifiers
[730.972085] Starting dynamic subtest: pipe-A
[731.306811] Dynamic subtest pipe-A: SUCCESS (0.339s)
[731.317045] Starting dynamic subtest: pipe-B
[732.736613] Dynamic subtest pipe-B: SUCCESS (1.429s)
[732.748855] Starting dynamic subtest: pipe-C
[734.184582] Dynamic subtest pipe-C: SUCCESS (1.447s)
[734.194295] Starting dynamic subtest: pipe-D
[735.600527] Dynamic subtest pipe-D: SUCCESS (1.414s)
[735.602751] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.634s)
[736.768851] [127/132] (284s left) kms_cursor_crc (cursor-offscreen-128x128)
[736.971223] Starting subtest: cursor-offscreen-128x128
[736.976050] Starting dynamic subtest: pipe-A-eDP-1
[738.936846] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.963s)
[738.967015] Starting dynamic subtest: pipe-D-eDP-1
[741.551157] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.592s)
[741.553472] Subtest cursor-offscreen-128x128: SUCCESS (4.579s)
[742.441485] [128/132] (279s left) kms_flip (2x-plain-flip-fb-recreate)
[742.543481] Starting subtest: 2x-plain-flip-fb-recreate
[742.554690] Subtest 2x-plain-flip-fb-recreate: SKIP (0.011s)
[742.696264] [129/132] (279s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-onoff)
[742.796594] Starting subtest: fbc-2p-scndscrn-cur-indfb-onoff
[742.800887] Subtest fbc-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[742.924017] [130/132] (278s left) gem_gpgpu_fill (basic)
[742.987752] Starting subtest: basic
[742.990104] Starting dynamic subtest: smem
[742.995039] Dynamic subtest smem: SUCCESS (0.007s)
[742.997314] Subtest basic: SUCCESS (0.008s)
[743.174239] [131/132] (278s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-msflip-blt)
[743.271527] Starting subtest: psr-1p-primscrn-indfb-msflip-blt
[750.518315] Subtest psr-1p-primscrn-indfb-msflip-blt: SUCCESS (7.250s)
[750.689571] [132/132] (271s left) perf (unprivileged-single-ctx-counters)
[750.805587] Starting subtest: unprivileged-single-ctx-counters
[750.809672] Subtest unprivileged-single-ctx-counters: SKIP (0.000s)
[750.849776] Closing watchdogs
results: parsing output: 0/ for test: kms_flip_scaled_crc
results: parsing output: 1/ for test: kms_rmfb
results: parsing output: 2/ for test: gen9_exec_parse
results: parsing output: 3/ for test: gem_ctx_param
results: parsing output: 4/ for test: kms_vrr
results: parsing output: 5/ for test: kms_frontbuffer_tracking
results: parsing output: 6/ for test: kms_flip_event_leak
results: parsing output: 7/ for test: gen9_exec_parse
results: parsing output: 8/ for test: kms_frontbuffer_tracking
results: parsing output: 9/ for test: i915_pm_rpm
results: parsing output: 10/ for test: gem_spin_batch
results: parsing output: 11/ for test: kms_cursor_legacy
results: parsing output: 12/ for test: syncobj_timeline
results: parsing output: 13/ for test: gem_ctx_param
results: parsing output: 14/ for test: kms_atomic
results: parsing output: 15/ for test: kms_pm_rpm
results: parsing output: 16/ for test: kms_color
results: parsing output: 17/ for test: kms_addfb_basic
results: parsing output: 18/ for test: kms_ccs
results: parsing output: 19/ for test: kms_joiner
results: parsing output: 20/ for test: gem_mmap_gtt
results: parsing output: 21/ for test: kms_chamelium_hpd
results: parsing output: 22/ for test: kms_ccs
results: parsing output: 23/ for test: kms_cursor_crc
results: parsing output: 24/ for test: gem_exec_basic
results: parsing output: 25/ for test: kms_cursor_legacy
results: parsing output: 26/ for test: gem_ctx_bad_destroy
results: parsing output: 27/ for test: kms_psr
results: parsing output: 28/ for test: gem_eio
results: parsing output: 29/ for test: kms_cursor_legacy
results: parsing output: 30/ for test: syncobj_wait
results: parsing output: 31/ for test: kms_sharpness_filter
results: parsing output: 32/ for test: kms_big_fb
results: parsing output: 33/ for test: kms_prop_blob
results: parsing output: 34/ for test: kms_psr
results: parsing output: 35/ for test: kms_cursor_legacy
results: parsing output: 36/ for test: gem_watchdog
results: parsing output: 37/ for test: kms_psr
results: parsing output: 38/ for test: gem_exec_reloc
results: parsing output: 39/ for test: kms_big_fb
results: parsing output: 40/ for test: kms_psr2_sf
results: parsing output: 41/ for test: gem_exec_reloc
results: parsing output: 42/ for test: kms_plane_alpha_blend
results: parsing output: 43/ for test: gem_eio
results: parsing output: 44/ for test: perf_pmu
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: kms_chamelium_audio
results: parsing output: 48/ for test: gem_exec_schedule
results: parsing output: 49/ for test: kms_ccs
results: parsing output: 50/ for test: gem_exec_schedule
results: parsing output: 51/ for test: kms_frontbuffer_tracking
results: parsing output: 52/ for test: gem_pread
results: parsing output: 53/ for test: syncobj_wait
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_fbcon_fbt
results: parsing output: 56/ for test: sysfs_timeslice_duration
results: parsing output: 57/ for test: perf
results: parsing output: 58/ for test: gem_userptr_blits
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: kms_cursor_legacy
results: parsing output: 61/ for test: dmabuf_sync_file
results: parsing output: 62/ for test: kms_frontbuffer_tracking
results: parsing output: 63/ for test: kms_scaling_modes
results: parsing output: 64/ for test: gem_ctx_exec
results: parsing output: 65/ for test: kms_chamelium_edid
results: parsing output: 66/ for test: gem_pxp
results: parsing output: 67/ for test: gem_userptr_blits
results: parsing output: 68/ for test: i915_pm_rps
results: parsing output: 69/ for test: gem_workarounds
results: parsing output: 70/ for test: prime_vgem
results: parsing output: 71/ for test: kms_frontbuffer_tracking
results: parsing output: 72/ for test: gem_mmap_offset
results: parsing output: 73/ for test: i915_hangman
results: parsing output: 74/ for test: kms_flip
results: parsing output: 75/ for test: gem_exec_parallel
results: parsing output: 76/ for test: syncobj_timeline
results: parsing output: 77/ for test: kms_frontbuffer_tracking
results: parsing output: 78/ for test: kms_cursor_crc
results: parsing output: 79/ for test: gem_exec_reloc
results: parsing output: 80/ for test: prime_busy
results: parsing output: 81/ for test: fbdev
results: parsing output: 82/ for test: kms_frontbuffer_tracking
results: parsing output: 83/ for test: kms_fbcon_fbt
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: kms_setmode
results: parsing output: 86/ for test: gem_mmap_gtt
results: parsing output: 87/ for test: kms_legacy_colorkey
results: parsing output: 88/ for test: kms_frontbuffer_tracking
results: parsing output: 89/ for test: kms_big_fb
results: parsing output: 90/ for test: gem_exec_fence
results: parsing output: 91/ for test: kms_ccs
results: parsing output: 92/ for test: kms_big_fb
results: parsing output: 93/ for test: gem_render_copy
results: parsing output: 94/ for test: gem_pwrite_snooped
results: parsing output: 95/ for test: syncobj_wait
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_exec_params
results: parsing output: 98/ for test: kms_psr
results: parsing output: 99/ for test: kms_frontbuffer_tracking
results: parsing output: 100/ for test: kms_big_fb
results: parsing output: 101/ for test: kms_frontbuffer_tracking
results: parsing output: 102/ for test: gem_exec_alignment
results: parsing output: 103/ for test: gem_exec_params
results: parsing output: 104/ for test: kms_frontbuffer_tracking
results: parsing output: 105/ for test: kms_invalid_mode
results: parsing output: 106/ for test: kms_psr2_sf
results: parsing output: 107/ for test: syncobj_timeline
results: parsing output: 108/ for test: gem_exec_balancer
results: parsing output: 109/ for test: gem_userptr_blits
results: parsing output: 110/ for test: syncobj_timeline
results: parsing output: 111/ for test: kms_frontbuffer_tracking
results: parsing output: 112/ for test: gem_ctx_persistence
results: parsing output: 113/ for test: kms_psr
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: core_setmaster_vs_auth
results: parsing output: 116/ for test: api_intel_allocator
results: parsing output: 117/ for test: kms_ccs
results: parsing output: 118/ for test: gem_exec_schedule
results: parsing output: 119/ for test: gem_mmap
results: parsing output: 120/ for test: api_intel_bb
results: parsing output: 121/ for test: kms_draw_crc
results: parsing output: 122/ for test: kms_plane_scaling
results: parsing output: 123/ for test: kms_frontbuffer_tracking
results: parsing output: 124/ for test: syncobj_timeline
results: parsing output: 125/ for test: kms_plane_scaling
results: parsing output: 126/ for test: kms_cursor_crc
results: parsing output: 127/ for test: kms_flip
results: parsing output: 128/ for test: kms_frontbuffer_tracking
results: parsing output: 129/ for test: gem_gpgpu_fill
results: parsing output: 130/ for test: kms_frontbuffer_tracking
results: parsing output: 131/ for test: perf
Done.