[58.738512] Initializing watchdogs [58.738563] /dev/watchdog0 [58.753769] [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] [58.758264] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.760566] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.764029] [001/156] (960s left) kms_vblank (ts-continuation-dpms-suspend) [58.898491] Starting subtest: ts-continuation-dpms-suspend [58.900738] Starting dynamic subtest: pipe-A-eDP-1 [75.729943] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.992s) [75.745131] Starting dynamic subtest: pipe-D-eDP-1 [93.735878] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.539s) [93.738384] Subtest ts-continuation-dpms-suspend: SUCCESS (4.533s) [94.552572] [002/156] (924s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-mmap-cpu) [94.671172] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-mmap-cpu [101.491389] Subtest psr-1p-offscreen-pri-shrfb-draw-mmap-cpu: SUCCESS (6.724s) [101.605763] [003/156] (917s left) kms_plane_scaling (plane-downscale-factor-0-75-with-rotation) [101.710390] Starting subtest: plane-downscale-factor-0-75-with-rotation [101.712850] Starting dynamic subtest: pipe-A [101.940609] Dynamic subtest pipe-A: SUCCESS (0.231s) [101.949368] Starting dynamic subtest: pipe-B [103.326523] Dynamic subtest pipe-B: SUCCESS (1.374s) [103.337003] Starting dynamic subtest: pipe-C [104.648676] Dynamic subtest pipe-C: SUCCESS (1.313s) [104.657349] Starting dynamic subtest: pipe-D [106.013330] Dynamic subtest pipe-D: SUCCESS (1.356s) [106.015535] Subtest plane-downscale-factor-0-75-with-rotation: SUCCESS (4.276s) [107.185286] [004/156] (912s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [107.287344] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [107.291668] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [107.383278] [005/156] (912s left) sysfs_preempt_timeout (invalid) [107.446675] Starting subtest: invalid [107.449229] Starting dynamic subtest: vecs0 [107.451490] Dynamic subtest vecs0: SUCCESS (0.000s) [107.461721] Starting dynamic subtest: ccs0 [107.463519] Dynamic subtest ccs0: SUCCESS (0.000s) [107.471963] Starting dynamic subtest: vcs0 [107.473868] Dynamic subtest vcs0: SUCCESS (0.000s) [107.482001] Starting dynamic subtest: bcs0 [107.484346] Dynamic subtest bcs0: SUCCESS (0.000s) [107.492745] Starting dynamic subtest: rcs0 [107.494565] Dynamic subtest rcs0: SUCCESS (0.000s) [107.503183] Starting dynamic subtest: vcs1 [107.505359] Dynamic subtest vcs1: SUCCESS (0.000s) [107.507498] Subtest invalid: SUCCESS (0.003s) [107.553645] [006/156] (911s left) gem_exec_reloc (basic-active) [107.606321] Subtest basic-active: SKIP (0.000s) [107.679125] [007/156] (911s left) kms_cursor_crc (cursor-tearing-framebuffer-change) [107.808672] Starting subtest: cursor-tearing-framebuffer-change [107.810968] Starting dynamic subtest: pipe-A-eDP-1 [108.414416] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.602s) [108.424915] Starting dynamic subtest: pipe-D-eDP-1 [109.616755] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.198s) [109.618858] Subtest cursor-tearing-framebuffer-change: SUCCESS (1.802s) [110.461622] [008/156] (909s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [110.565564] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [110.569757] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [110.662543] [009/156] (908s left) gem_gpgpu_fill (offset-16x16) [110.723751] Starting subtest: offset-16x16 [110.730793] Subtest offset-16x16: SUCCESS (0.008s) [110.894004] [010/156] (908s left) syncobj_timeline (single-wait-all-for-submit-available-submitted) [110.950850] Starting subtest: single-wait-all-for-submit-available-submitted [110.953275] Subtest single-wait-all-for-submit-available-submitted: SUCCESS (0.000s) [111.054473] [011/156] (908s left) gem_exec_capture (capture) [111.109132] Starting subtest: capture [111.111381] Starting dynamic subtest: rcs0-smem [111.931650] Dynamic subtest rcs0-smem: SUCCESS (0.821s) [111.940414] Starting dynamic subtest: bcs0-smem [112.801039] Dynamic subtest bcs0-smem: SUCCESS (0.865s) [112.812105] Starting dynamic subtest: vcs0-smem [113.598814] Dynamic subtest vcs0-smem: SUCCESS (0.797s) [113.609859] Starting dynamic subtest: vcs1-smem [114.405444] Dynamic subtest vcs1-smem: SUCCESS (0.804s) [114.416290] Starting dynamic subtest: vecs0-smem [115.799328] Dynamic subtest vecs0-smem: FAIL (1.332s) [115.809467] Starting dynamic subtest: ccs0-smem [117.069795] Dynamic subtest ccs0-smem: SUCCESS (1.327s) [117.071933] Subtest capture: FAIL (5.949s) [117.205172] [012/156] (902s left) gem_ctx_persistence (hang) [117.267722] Starting subtest: hang [117.272422] Subtest hang: SKIP (0.000s) [117.382977] [013/156] (902s left) syncobj_wait (reset-during-wait-for-submit) [117.429069] Starting subtest: reset-during-wait-for-submit [117.531311] Subtest reset-during-wait-for-submit: SUCCESS (0.103s) [117.625084] [014/156] (902s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [117.741202] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [117.745716] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [117.837544] [015/156] (902s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-indfb-pgflip-blt) [117.944652] Starting subtest: fbchdr-1p-primscrn-indfb-pgflip-blt [117.949100] Subtest fbchdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [118.019886] [016/156] (901s left) gem_exec_reloc (basic-gtt-cpu) [118.080246] Subtest basic-gtt-cpu: SKIP (0.000s) [118.164351] [017/156] (901s left) kms_plane (pixel-format-4-tiled-modifier) [118.256166] Starting subtest: pixel-format-4-tiled-modifier [118.282485] Starting dynamic subtest: pipe-A-plane-0 [118.649756] Dynamic subtest pipe-A-plane-0: SUCCESS (0.367s) [118.658603] Starting dynamic subtest: pipe-A-plane-3 [118.950283] Dynamic subtest pipe-A-plane-3: SUCCESS (0.299s) [118.959989] Starting dynamic subtest: pipe-A-plane-5 [118.965638] Dynamic subtest pipe-A-plane-5: SKIP (0.000s) [120.066585] Starting dynamic subtest: pipe-B-plane-0 [120.480599] Dynamic subtest pipe-B-plane-0: SUCCESS (0.422s) [120.490981] Starting dynamic subtest: pipe-B-plane-3 [120.815763] Dynamic subtest pipe-B-plane-3: SUCCESS (0.333s) [120.826330] Starting dynamic subtest: pipe-B-plane-5 [120.830689] Dynamic subtest pipe-B-plane-5: SKIP (0.000s) [121.139869] Subtest pixel-format-4-tiled-modifier: SUCCESS (2.879s) [121.951913] [018/156] (898s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [122.048486] Starting subtest: fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt [122.052873] Subtest fbchdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [122.156682] [019/156] (897s left) kms_universal_plane (disable-primary-vs-flip) [122.251449] Starting subtest: disable-primary-vs-flip [122.253967] Starting dynamic subtest: pipe-A-eDP-1 [123.831480] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.580s) [123.842611] Starting dynamic subtest: pipe-B-eDP-1 [126.103211] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.270s) [126.114350] Starting dynamic subtest: pipe-C-eDP-1 [128.344150] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.239s) [128.355025] Starting dynamic subtest: pipe-D-eDP-1 [130.615431] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.272s) [130.617692] Subtest disable-primary-vs-flip: SUCCESS (8.366s) [131.490230] [020/156] (888s left) kms_psr (fbc-pr-primary-mmap-gtt) [131.594215] Starting subtest: fbc-pr-primary-mmap-gtt [131.598488] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [131.678055] [021/156] (888s left) i915_selftest (perf) [135.002996] Starting subtest: perf [135.005895] Starting dynamic subtest: engine_cs [139.349941] Dynamic subtest engine_cs: SUCCESS (4.348s) [139.359712] Starting dynamic subtest: request [146.627656] Dynamic subtest request: SUCCESS (7.276s) [146.637765] Starting dynamic subtest: migrate [151.058283] Dynamic subtest migrate: SUCCESS (4.429s) [151.072789] Starting dynamic subtest: region [156.761028] Dynamic subtest region: SUCCESS (5.700s) [156.763548] Subtest perf: SUCCESS (21.758s) [156.791947] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [156.795191] [022/156] (863s left) kms_joiner (invalid-modeset-ultra-joiner) [158.410753] Starting subtest: invalid-modeset-ultra-joiner [158.415345] Subtest invalid-modeset-ultra-joiner: SKIP (0.000s) [158.501976] [FACT kms_joiner (invalid-modeset-ultra-joiner)] new: kernel.kmod_is_loaded.i915: true [158.505991] [023/156] (861s left) kms_addfb_basic (bad-pitch-128) [158.565820] Starting subtest: bad-pitch-128 [158.568130] Subtest bad-pitch-128: SUCCESS (0.000s) [158.695652] [024/156] (861s left) kms_psr (pr-sprite-mmap-gtt) [158.784402] Starting subtest: pr-sprite-mmap-gtt [158.788424] Subtest pr-sprite-mmap-gtt: SKIP (0.000s) [158.869968] [025/156] (861s left) gen3_mixed_blits [158.976217] [026/156] (861s left) kms_cursor_legacy (short-busy-flip-before-cursor-toggle) [159.090812] Starting subtest: short-busy-flip-before-cursor-toggle [159.095185] Subtest short-busy-flip-before-cursor-toggle: SKIP (0.000s) [159.234839] [027/156] (861s left) syncobj_wait (multi-wait-all-for-submit-submitted) [159.290951] Starting subtest: multi-wait-all-for-submit-submitted [159.397593] Subtest multi-wait-all-for-submit-submitted: SUCCESS (0.106s) [159.475140] [028/156] (860s left) syncobj_wait (invalid-signal-zero-handles) [159.532407] Starting subtest: invalid-signal-zero-handles [159.534553] Subtest invalid-signal-zero-handles: SUCCESS (0.000s) [159.618868] [029/156] (860s left) kms_flip_scaled_crc (flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [159.715067] Starting subtest: flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [159.719257] Subtest flip-64bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.000s) [159.803311] [030/156] (860s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render) [159.903537] Starting subtest: fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render [159.907933] Subtest fbcpsrhdr-2p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [159.995690] [031/156] (860s left) kms_flip_scaled_crc (flip-64bpp-linear-to-16bpp-linear-upscaling) [160.084771] Starting subtest: flip-64bpp-linear-to-16bpp-linear-upscaling [160.087001] Starting dynamic subtest: pipe-A-default-mode [162.870359] Dynamic subtest pipe-A-default-mode: SUCCESS (2.785s) [162.872648] Subtest flip-64bpp-linear-to-16bpp-linear-upscaling: SUCCESS (2.786s) [163.747261] [032/156] (856s left) kms_cursor_legacy (cursora-vs-flipa-varying-size) [163.862313] Starting subtest: cursorA-vs-flipA-varying-size [175.020989] Subtest cursorA-vs-flipA-varying-size: SUCCESS (11.153s) [175.864474] [033/156] (844s left) kms_frontbuffer_tracking (hdr-2p-primscrn-shrfb-pgflip-blt) [175.966289] Starting subtest: hdr-2p-primscrn-shrfb-pgflip-blt [175.970870] Subtest hdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [176.047476] [034/156] (844s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-msflip-blt) [176.143755] Starting subtest: fbcpsr-2p-primscrn-indfb-msflip-blt [176.148252] Subtest fbcpsr-2p-primscrn-indfb-msflip-blt: SKIP (0.000s) [176.245779] [035/156] (844s left) kms_chamelium_frames (hdmi-aspect-ratio) [176.640880] Subtest hdmi-aspect-ratio: SKIP (0.000s) [177.483619] [036/156] (843s left) gem_exec_schedule (manyslice) [177.548847] Starting subtest: manyslice [177.551029] Starting dynamic subtest: rcs0 [182.741457] Dynamic subtest rcs0: SUCCESS (5.144s) [182.754296] Starting dynamic subtest: bcs0 [189.389043] Dynamic subtest bcs0: SUCCESS (6.643s) [189.397913] Starting dynamic subtest: vcs0 [194.468588] Dynamic subtest vcs0: SUCCESS (5.078s) [194.478305] Starting dynamic subtest: vcs1 [200.039054] Dynamic subtest vcs1: SUCCESS (5.571s) [200.048844] Starting dynamic subtest: vecs0 [206.624205] Dynamic subtest vecs0: SUCCESS (6.584s) [206.634327] Starting dynamic subtest: ccs0 [213.309274] Dynamic subtest ccs0: SUCCESS (6.683s) [213.311652] Subtest manyslice: SUCCESS (35.714s) [213.561231] [037/156] (807s left) kms_content_protection (content-type-change) [213.702915] Starting subtest: content-type-change [213.707548] Subtest content-type-change: SKIP (0.000s) [213.840729] [038/156] (806s left) i915_drm_fdinfo (all-busy-idle-check-all) [213.883637] Starting subtest: all-busy-idle-check-all [213.890377] Subtest all-busy-idle-check-all: SKIP (0.005s) [213.947159] [039/156] (806s left) kms_ccs (crc-sprite-planes-basic-y-tiled-gen12-rc-ccs) [214.042448] Starting subtest: crc-sprite-planes-basic-y-tiled-gen12-rc-ccs [214.044866] Starting dynamic subtest: pipe-A-eDP-1 [214.104585] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [214.113378] Starting dynamic subtest: pipe-B-eDP-1 [214.169368] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [214.179509] Starting dynamic subtest: pipe-C-eDP-1 [214.236902] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [214.247056] Starting dynamic subtest: pipe-D-eDP-1 [214.304736] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [214.308960] Subtest crc-sprite-planes-basic-y-tiled-gen12-rc-ccs: SKIP (0.009s) [216.357655] [040/156] (804s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [216.460114] Starting subtest: plane-upscale-20x20-with-rotation [216.462461] Starting dynamic subtest: pipe-A [216.684235] Dynamic subtest pipe-A: SUCCESS (0.227s) [216.693687] Starting dynamic subtest: pipe-B [217.945323] Dynamic subtest pipe-B: SUCCESS (1.260s) [217.955219] Starting dynamic subtest: pipe-C [219.269582] Dynamic subtest pipe-C: SUCCESS (1.324s) [219.278908] Starting dynamic subtest: pipe-D [220.607544] Dynamic subtest pipe-D: SUCCESS (1.336s) [220.609988] Subtest plane-upscale-20x20-with-rotation: SUCCESS (4.151s) [221.814661] [041/156] (799s left) gem_exec_flush (basic-uc-prw-default) [221.877298] Starting subtest: basic-uc-prw-default [227.357607] Subtest basic-uc-prw-default: SUCCESS (5.462s) [227.538078] [042/156] (793s left) kms_cursor_crc (cursor-offscreen-128x42) [227.778091] Starting subtest: cursor-offscreen-128x42 [227.833523] Subtest cursor-offscreen-128x42: SKIP (0.050s) [228.033421] [043/156] (792s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-0) [228.138503] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-0 [229.139726] Subtest x-tiled-max-hw-stride-64bpp-rotate-0: SUCCESS (1.001s) [229.272377] [044/156] (791s left) syncobj_eventfd (timeline-wait-signaled) [229.328495] Starting subtest: timeline-wait-signaled [229.330804] Subtest timeline-wait-signaled: SUCCESS (0.000s) [229.440068] [045/156] (791s left) gem_mmap_offset (bad-extensions) [229.499136] Starting subtest: bad-extensions [229.500962] Subtest bad-extensions: SUCCESS (0.000s) [229.595398] [046/156] (791s left) kms_psr (psr-sprite-plane-onoff) [229.681378] Starting subtest: psr-sprite-plane-onoff [229.683406] Starting dynamic subtest: eDP-1 [231.432837] Dynamic subtest eDP-1: SUCCESS (1.751s) [231.435237] Subtest psr-sprite-plane-onoff: SUCCESS (1.752s) [232.273826] [047/156] (788s left) gem_workarounds (basic-read-fd) [232.349752] Starting subtest: basic-read-fd [232.360667] Subtest basic-read-fd: SUCCESS (0.010s) [232.471170] [048/156] (788s left) kms_flip (flip-vs-rmfb-interruptible) [232.568518] Starting subtest: flip-vs-rmfb-interruptible [232.570881] Starting dynamic subtest: A-eDP1 [241.255306] Dynamic subtest A-eDP1: SUCCESS (8.685s) [241.264547] Starting dynamic subtest: B-eDP1 [249.876164] Dynamic subtest B-eDP1: SUCCESS (8.618s) [249.887824] Starting dynamic subtest: C-eDP1 [258.495593] Dynamic subtest C-eDP1: SUCCESS (8.615s) [258.506526] Starting dynamic subtest: D-eDP1 [267.126160] Dynamic subtest D-eDP1: SUCCESS (8.627s) [267.130461] Subtest flip-vs-rmfb-interruptible: SUCCESS (34.556s) [268.307884] [049/156] (752s left) kms_plane (pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping) [268.399313] Starting subtest: pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping [268.403671] Subtest pixel-format-y-tiled-gen12-mc-ccs-modifier-source-clamping: SKIP (0.000s) [268.472990] [050/156] (752s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-rc-ccs) [268.563313] Starting subtest: ccs-on-another-bo-y-tiled-gen12-rc-ccs [268.565736] Starting dynamic subtest: pipe-A-eDP-1 [268.588859] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [268.601523] Starting dynamic subtest: pipe-B-eDP-1 [268.622535] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [268.631282] Starting dynamic subtest: pipe-C-eDP-1 [268.652086] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [268.661000] Starting dynamic subtest: pipe-D-eDP-1 [268.683006] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [268.687341] Subtest ccs-on-another-bo-y-tiled-gen12-rc-ccs: SKIP (0.005s) [270.871024] [051/156] (750s left) kms_pm_rpm (dpms-mode-unset-lpsp) [272.714177] Starting subtest: dpms-mode-unset-lpsp [276.792244] Subtest dpms-mode-unset-lpsp: SUCCESS (4.080s) [277.184677] [052/156] (744s left) gem_exec_whisper (basic-contexts-all) [277.249476] Starting subtest: basic-contexts-all [288.288840] Subtest basic-contexts-all: SUCCESS (11.037s) [288.487765] [053/156] (732s left) perf (global-sseu-config) [288.620162] Starting subtest: global-sseu-config [288.624575] Subtest global-sseu-config: SKIP (0.000s) [288.660786] [054/156] (732s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-shrfb-pgflip-blt) [288.770881] Starting subtest: fbchdr-2p-primscrn-shrfb-pgflip-blt [288.775015] Subtest fbchdr-2p-primscrn-shrfb-pgflip-blt: SKIP (0.000s) [288.862113] [055/156] (732s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [288.950355] Starting subtest: primary-y-tiled-reflect-x-0 [289.020123] Subtest primary-y-tiled-reflect-x-0: SKIP (0.071s) [289.123525] [056/156] (732s left) gem_ctx_shared (single-timeline) [289.181131] Starting subtest: single-timeline [289.201715] Subtest single-timeline: SUCCESS (0.015s) [289.447797] [057/156] (732s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [289.544413] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-mmap-cpu [289.548859] Subtest psr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [289.651209] [058/156] (731s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [289.755261] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [289.759384] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [289.850091] [059/156] (731s left) gem_tiling_max_stride [289.987234] [060/156] (731s left) gem_softpin (allocator-nopin) [290.034460] Starting subtest: allocator-nopin [290.115990] Subtest allocator-nopin: SUCCESS (0.081s) [290.275386] [061/156] (731s left) kms_atomic (plane-cursor-legacy) [290.359167] Starting subtest: plane-cursor-legacy [290.361061] Starting dynamic subtest: pipe-A-eDP-1 [290.728009] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.367s) [290.730371] Subtest plane-cursor-legacy: SUCCESS (0.368s) [291.606706] [062/156] (730s left) kms_async_flips (async-flip-with-page-flip-events-tiled-atomic) [291.704687] Starting subtest: async-flip-with-page-flip-events-tiled-atomic [292.089031] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs [294.939246] Dynamic subtest pipe-A-eDP-1-4-rc-ccs: SUCCESS (2.795s) [294.949574] Starting dynamic subtest: pipe-A-eDP-1-4 [297.125013] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.184s) [297.135486] Starting dynamic subtest: pipe-A-eDP-1-4 [299.091542] Dynamic subtest pipe-A-eDP-1-4: SUCCESS (2.007s) [299.104369] Starting dynamic subtest: pipe-A-eDP-1-x [301.325199] Dynamic subtest pipe-A-eDP-1-x: SUCCESS (2.188s) [301.651713] Starting dynamic subtest: pipe-B-eDP-1-4-rc-ccs [304.468172] Dynamic subtest pipe-B-eDP-1-4-rc-ccs: SUCCESS (2.771s) [304.481375] Starting dynamic subtest: pipe-B-eDP-1-4 [306.653938] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.183s) [306.666827] Starting dynamic subtest: pipe-B-eDP-1-4 [308.613002] Dynamic subtest pipe-B-eDP-1-4: SUCCESS (2.008s) [308.622824] Starting dynamic subtest: pipe-B-eDP-1-x [310.855397] Dynamic subtest pipe-B-eDP-1-x: SUCCESS (2.188s) [311.175982] Starting dynamic subtest: pipe-C-eDP-1-4-rc-ccs [314.004818] Dynamic subtest pipe-C-eDP-1-4-rc-ccs: SUCCESS (2.781s) [314.019556] Starting dynamic subtest: pipe-C-eDP-1-4 [316.187131] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.184s) [316.198986] Starting dynamic subtest: pipe-C-eDP-1-4 [318.147813] Dynamic subtest pipe-C-eDP-1-4: SUCCESS (2.009s) [318.158650] Starting dynamic subtest: pipe-C-eDP-1-x [320.378062] Dynamic subtest pipe-C-eDP-1-x: SUCCESS (2.179s) [320.694824] Starting dynamic subtest: pipe-D-eDP-1-4-rc-ccs [323.485081] Dynamic subtest pipe-D-eDP-1-4-rc-ccs: SUCCESS (2.803s) [323.499594] Starting dynamic subtest: pipe-D-eDP-1-4 [325.723134] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.184s) [325.735287] Starting dynamic subtest: pipe-D-eDP-1-4 [327.679246] Dynamic subtest pipe-D-eDP-1-4: SUCCESS (2.008s) [327.690752] Starting dynamic subtest: pipe-D-eDP-1-x [329.869581] Dynamic subtest pipe-D-eDP-1-x: SUCCESS (2.189s) [329.872283] Subtest async-flip-with-page-flip-events-tiled-atomic: SUCCESS (38.162s) [331.078707] [063/156] (690s left) gem_render_copy (yf-tiled-to-vebox-linear) [331.142014] Starting subtest: yf-tiled-to-vebox-linear [331.146216] Subtest yf-tiled-to-vebox-linear: SKIP (0.000s) [331.328087] [064/156] (690s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [331.424222] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [331.426468] Starting dynamic subtest: pipe-A-eDP-1 [331.452269] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [331.465031] Starting dynamic subtest: pipe-B-eDP-1 [331.488473] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [331.498742] Starting dynamic subtest: pipe-C-eDP-1 [331.522955] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [331.532448] Starting dynamic subtest: pipe-D-eDP-1 [331.556555] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [331.560976] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.005s) [333.730357] [065/156] (688s left) gem_sync (basic-each) [333.797189] Starting subtest: basic-each [336.142895] Subtest basic-each: SUCCESS (2.356s) [336.328236] [066/156] (685s left) api_intel_bb (intel-bb-blit-x) [336.374865] Starting subtest: intel-bb-blit-x [340.214737] Subtest intel-bb-blit-x: SUCCESS (3.840s) [340.325165] [067/156] (681s left) kms_big_fb (yf-tiled-addfb) [340.427845] Starting subtest: yf-tiled-addfb [340.432318] Subtest yf-tiled-addfb: SKIP (0.000s) [340.537492] [068/156] (681s left) gem_pwrite (basic-exhaustion) [340.599634] Subtest basic-exhaustion: SKIP (0.000s) [340.655261] [069/156] (681s left) kms_draw_crc (draw-method-blt) [340.745969] Starting subtest: draw-method-blt [340.747838] Starting dynamic subtest: xrgb8888-untiled [340.977479] Dynamic subtest xrgb8888-untiled: SUCCESS (0.233s) [340.987986] Starting dynamic subtest: rgb565-untiled [341.210311] Dynamic subtest rgb565-untiled: SUCCESS (0.232s) [341.220729] Starting dynamic subtest: xrgb2101010-untiled [341.432416] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.222s) [341.442026] Starting dynamic subtest: xbgr16161616f-untiled [341.632467] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.199s) [341.641896] Starting dynamic subtest: xrgb8888-xtiled [341.743462] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.110s) [341.753164] Starting dynamic subtest: rgb565-xtiled [341.865638] Dynamic subtest rgb565-xtiled: SUCCESS (0.121s) [341.882037] Starting dynamic subtest: xrgb2101010-xtiled [341.976964] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.110s) [341.986704] Starting dynamic subtest: xbgr16161616f-xtiled [342.098839] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.120s) [342.108215] Starting dynamic subtest: xrgb8888-4tiled [342.220982] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.121s) [342.230508] Starting dynamic subtest: rgb565-4tiled [342.320963] Dynamic subtest rgb565-4tiled: SUCCESS (0.099s) [342.330109] Starting dynamic subtest: xrgb2101010-4tiled [342.432253] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.111s) [342.441566] Starting dynamic subtest: xbgr16161616f-4tiled [342.543359] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.110s) [342.545322] Subtest draw-method-blt: SUCCESS (1.800s) [342.649112] [070/156] (679s left) kms_frontbuffer_tracking (fbchdr-rgb565-draw-mmap-cpu) [342.744738] Starting subtest: fbchdr-rgb565-draw-mmap-cpu [342.748270] Subtest fbchdr-rgb565-draw-mmap-cpu: SKIP (0.000s) [342.833684] [071/156] (679s left) kms_plane_lowres (tiling-4) [342.917446] Starting subtest: tiling-4 [342.919490] Starting dynamic subtest: pipe-A-eDP-1 [342.923365] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [343.237799] Starting dynamic subtest: pipe-B-eDP-1 [343.242946] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [343.254375] Starting dynamic subtest: pipe-C-eDP-1 [343.258710] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [343.268016] Starting dynamic subtest: pipe-D-eDP-1 [343.272015] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [343.275986] Subtest tiling-4: SKIP (0.316s) [344.060304] [072/156] (678s left) kms_frontbuffer_tracking (fbc-1p-primscrn-indfb-pgflip-blt) [344.159524] Starting subtest: fbc-1p-primscrn-indfb-pgflip-blt [348.738254] Subtest fbc-1p-primscrn-indfb-pgflip-blt: SUCCESS (4.584s) [349.868600] [073/156] (672s left) gem_watchdog (default-virtual) [349.940594] Starting subtest: default-virtual [356.215316] Subtest default-virtual: SUCCESS (6.284s) [356.316779] [074/156] (665s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt) [356.419554] Starting subtest: fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt [356.423667] Subtest fbcpsrhdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [356.512574] [075/156] (665s left) gem_exec_fence (basic-busy-all) [356.576549] Starting subtest: basic-busy-all [356.673157] Subtest basic-busy-all: SUCCESS (0.096s) [358.618316] [FACT gem_exec_fence (basic-busy-all)] new: kernel.kmod_is_loaded.vgem: true [358.621951] [076/156] (663s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [358.725602] Starting subtest: pr-plane-move-sf-dmg-area [358.729740] Subtest pr-plane-move-sf-dmg-area: SKIP (0.000s) [358.809666] [077/156] (663s left) kms_ccs (crc-primary-rotation-180-y-tiled-ccs) [358.899126] Starting subtest: crc-primary-rotation-180-y-tiled-ccs [358.901393] Starting dynamic subtest: pipe-A-eDP-1 [358.924035] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [358.936460] Starting dynamic subtest: pipe-B-eDP-1 [358.959412] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [358.969116] Starting dynamic subtest: pipe-C-eDP-1 [358.996658] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [359.006150] Starting dynamic subtest: pipe-D-eDP-1 [359.028160] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [359.032760] Subtest crc-primary-rotation-180-y-tiled-ccs: SKIP (0.006s) [361.209273] [078/156] (661s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [361.306399] Starting subtest: hdr-1p-primscrn-pri-indfb-draw-mmap-gtt [361.310503] Subtest hdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [361.399671] [079/156] (661s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-move) [361.508532] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-move [361.512804] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [361.629110] [080/156] (660s left) api_intel_allocator (standalone) [361.683348] Starting subtest: standalone [361.699413] Subtest standalone: SUCCESS (0.018s) [361.828823] [081/156] (660s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt) [361.922972] Starting subtest: fbc-rgb101010-draw-blt [364.428296] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.510s) [365.645304] [082/156] (656s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [365.743220] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [365.747965] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [365.851570] [083/156] (656s left) gem_exec_params (invalid-bsd1-flag-on-vebox) [365.909588] Starting subtest: invalid-bsd1-flag-on-vebox [365.912158] Subtest invalid-bsd1-flag-on-vebox: SUCCESS (0.000s) [366.015089] [084/156] (656s left) gem_userptr_blits (usage-restrictions) [366.075995] Starting subtest: usage-restrictions [366.077984] Subtest usage-restrictions: SUCCESS (0.000s) [366.195962] [085/156] (656s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt) [366.300087] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt [366.304165] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [366.399975] [086/156] (656s left) kms_psr (fbc-psr-sprite-render) [366.495098] Starting subtest: fbc-psr-sprite-render [366.497407] Starting dynamic subtest: eDP-1 [366.501791] Dynamic subtest eDP-1: SKIP (0.000s) [366.506226] Subtest fbc-psr-sprite-render: SKIP (0.001s) [366.567102] [087/156] (656s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-fullscreen) [366.669116] Starting subtest: psrhdr-1p-primscrn-spr-indfb-fullscreen [366.672656] Subtest psrhdr-1p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [366.763283] [088/156] (656s left) kms_big_fb (y-tiled-addfb-size-offset-overflow) [366.872022] Starting subtest: y-tiled-addfb-size-offset-overflow [366.875727] Subtest y-tiled-addfb-size-offset-overflow: SKIP (0.000s) [366.982481] [089/156] (655s left) kms_flip (2x-plain-flip-ts-check) [367.073353] Starting subtest: 2x-plain-flip-ts-check [367.084466] Subtest 2x-plain-flip-ts-check: SKIP (0.012s) [367.175518] [090/156] (655s left) gen9_exec_parse (basic-rejected-ctx-param) [367.232864] Subtest basic-rejected-ctx-param: SKIP (0.000s) [367.301517] [091/156] (655s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite) [367.407257] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite [367.410691] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [367.507525] [092/156] (655s left) kms_chamelium_hpd (hdmi-hpd-storm) [367.887154] Subtest hdmi-hpd-storm: SKIP (0.000s) [368.723345] [093/156] (654s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen) [368.828205] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen [368.832769] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s) [368.931543] [094/156] (654s left) kms_frontbuffer_tracking (hdr-indfb-scaledprimary) [369.042687] Starting subtest: hdr-indfb-scaledprimary [369.047125] Subtest hdr-indfb-scaledprimary: SKIP (0.000s) [369.153534] [095/156] (653s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-render) [369.257326] Starting subtest: psr-1p-primscrn-cur-indfb-draw-render [376.037426] Subtest psr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.785s) [376.161560] [096/156] (647s left) kms_busy (basic) [376.268385] Starting subtest: basic [376.270611] Starting dynamic subtest: flip [376.861862] Dynamic subtest flip: SUCCESS (0.595s) [376.874855] Starting dynamic subtest: modeset [380.281993] Dynamic subtest modeset: SUCCESS (3.418s) [380.284409] Subtest basic: SUCCESS (4.015s) [381.103782] [097/156] (642s left) kms_cursor_legacy (2x-long-cursor-vs-flip-legacy) [381.230761] Starting subtest: 2x-long-cursor-vs-flip-legacy [381.235406] Subtest 2x-long-cursor-vs-flip-legacy: SKIP (0.001s) [381.399174] [098/156] (641s left) kms_color_pipeline (plane-lut1d-ctm3x4) [381.489167] Starting subtest: plane-lut1d-ctm3x4 [381.657367] Starting dynamic subtest: pipe-A-plane-0 [381.835477] Dynamic subtest pipe-A-plane-0: SUCCESS (0.178s) [381.846567] Starting dynamic subtest: pipe-A-plane-1 [381.990289] Dynamic subtest pipe-A-plane-1: SUCCESS (0.154s) [382.002751] Starting dynamic subtest: pipe-A-plane-2 [382.167388] Dynamic subtest pipe-A-plane-2: SUCCESS (0.177s) [383.388602] Starting dynamic subtest: pipe-B-plane-0 [383.557819] Dynamic subtest pipe-B-plane-0: SUCCESS (0.178s) [383.567796] Starting dynamic subtest: pipe-B-plane-1 [383.724573] Dynamic subtest pipe-B-plane-1: SUCCESS (0.166s) [383.735162] Starting dynamic subtest: pipe-B-plane-2 [383.890862] Dynamic subtest pipe-B-plane-2: SUCCESS (0.166s) [385.132503] Starting dynamic subtest: pipe-C-plane-0 [385.290908] Dynamic subtest pipe-C-plane-0: SUCCESS (0.166s) [385.301848] Starting dynamic subtest: pipe-C-plane-1 [385.446365] Dynamic subtest pipe-C-plane-1: SUCCESS (0.155s) [385.457359] Starting dynamic subtest: pipe-C-plane-2 [385.613363] Dynamic subtest pipe-C-plane-2: SUCCESS (0.166s) [386.844850] Starting dynamic subtest: pipe-D-plane-0 [387.003058] Dynamic subtest pipe-D-plane-0: SUCCESS (0.166s) [387.016298] Starting dynamic subtest: pipe-D-plane-1 [387.158385] Dynamic subtest pipe-D-plane-1: SUCCESS (0.155s) [387.169347] Starting dynamic subtest: pipe-D-plane-2 [387.325252] Dynamic subtest pipe-D-plane-2: SUCCESS (0.166s) [387.613948] Subtest plane-lut1d-ctm3x4: SUCCESS (6.124s) [388.498237] [099/156] (634s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-pri-indfb-draw-render) [388.605068] Starting subtest: psrhdr-2p-primscrn-pri-indfb-draw-render [388.609322] Subtest psrhdr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [388.707177] [100/156] (634s left) kms_cursor_crc (cursor-rapid-movement-256x85) [388.980022] Starting subtest: cursor-rapid-movement-256x85 [389.029521] Subtest cursor-rapid-movement-256x85: SKIP (0.049s) [389.209958] [101/156] (634s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-submitted-signaled) [389.260766] Starting subtest: invalid-multi-wait-all-unsubmitted-submitted-signaled [389.263111] Subtest invalid-multi-wait-all-unsubmitted-submitted-signaled: SUCCESS (0.000s) [389.357270] [102/156] (634s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [389.450999] Starting subtest: bad-pixel-format-yf-tiled-ccs [389.453105] Starting dynamic subtest: pipe-A-eDP-1 [389.473430] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [389.485057] Starting dynamic subtest: pipe-B-eDP-1 [389.504596] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [389.516555] Starting dynamic subtest: pipe-C-eDP-1 [389.534460] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [389.543575] Starting dynamic subtest: pipe-D-eDP-1 [389.561713] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [389.565354] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.005s) [391.775889] [103/156] (631s left) kms_psr (fbc-psr2-dpms) [391.870013] Starting subtest: fbc-psr2-dpms [391.872301] Starting dynamic subtest: eDP-1 [391.876708] Dynamic subtest eDP-1: SKIP (0.000s) [391.881135] Subtest fbc-psr2-dpms: SKIP (0.001s) [391.949509] [104/156] (631s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-draw-render) [392.050646] Starting subtest: fbchdr-2p-primscrn-cur-indfb-draw-render [392.054696] Subtest fbchdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [392.162013] [105/156] (631s left) gem_userptr_blits (readonly-unsync) [392.221780] Subtest readonly-unsync: SKIP (0.000s) [392.350239] [106/156] (631s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-wc) [392.455074] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-wc [396.793388] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-wc: SUCCESS (4.345s) [397.946569] [107/156] (625s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt) [398.042116] Starting subtest: psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt [398.046052] Subtest psrhdr-1p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [398.143072] [108/156] (625s left) gem_exec_schedule (smoketest) [398.319152] Starting subtest: smoketest [398.322947] Starting dynamic subtest: rcs0 [403.931977] Dynamic subtest rcs0: SUCCESS (5.501s) [403.945330] Starting dynamic subtest: bcs0 [409.443557] Dynamic subtest bcs0: SUCCESS (5.520s) [409.456821] Starting dynamic subtest: vcs0 [414.938357] Dynamic subtest vcs0: SUCCESS (5.490s) [414.952805] Starting dynamic subtest: vcs1 [420.440727] Dynamic subtest vcs1: SUCCESS (5.505s) [420.453146] Starting dynamic subtest: vecs0 [425.936742] Dynamic subtest vecs0: SUCCESS (5.489s) [425.948832] Starting dynamic subtest: ccs0 [431.426393] Dynamic subtest ccs0: SUCCESS (5.486s) [431.428530] Subtest smoketest: SUCCESS (32.998s) [431.512426] [109/156] (592s left) kms_cursor_legacy (cursora-vs-flipa-atomic-transitions-varying-size) [431.630768] Starting subtest: cursorA-vs-flipA-atomic-transitions-varying-size [442.796487] Subtest cursorA-vs-flipA-atomic-transitions-varying-size: SUCCESS (11.164s) [443.672010] [110/156] (580s left) device_reset (unbind-cold-reset-rebind) [443.725170] Starting subtest: unbind-cold-reset-rebind [443.729656] Subtest unbind-cold-reset-rebind: SKIP (0.000s) [443.799204] [111/156] (580s left) kms_frontbuffer_tracking (psrhdr-rgb101010-draw-mmap-gtt) [443.891739] Starting subtest: psrhdr-rgb101010-draw-mmap-gtt [443.895634] Subtest psrhdr-rgb101010-draw-mmap-gtt: SKIP (0.000s) [443.994379] [112/156] (579s left) kms_flip (2x-plain-flip-ts-check-interruptible) [444.081615] Starting subtest: 2x-plain-flip-ts-check-interruptible [444.094485] Subtest 2x-plain-flip-ts-check-interruptible: SKIP (0.011s) [444.173526] [113/156] (579s left) gem_compute (compute-square) [444.221910] Starting subtest: compute-square [444.225228] Subtest compute-square: SUCCESS (0.006s) [444.341834] [114/156] (579s left) kms_getfb (getfb2-handle-closed) [444.431700] Starting subtest: getfb2-handle-closed [444.434027] Subtest getfb2-handle-closed: SUCCESS (0.000s) [444.555757] [115/156] (579s left) kms_pm_rpm (system-suspend-modeset) [446.681105] Starting subtest: system-suspend-modeset [466.682342] Subtest system-suspend-modeset: SUCCESS (4.564s) [467.076866] [116/156] (556s left) gem_exec_fence (syncobj-stationary-timeline-chain-engines) [467.661463] Starting subtest: syncobj-stationary-timeline-chain-engines [467.787687] Subtest syncobj-stationary-timeline-chain-engines: SUCCESS (0.124s) [468.993719] [117/156] (555s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move) [469.091418] Starting subtest: psr-2p-primscrn-cur-indfb-move [469.095563] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s) [469.206512] [118/156] (554s left) gem_mmap (basic) [469.262368] Subtest basic: SKIP (0.000s) [469.327970] [119/156] (554s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-render) [469.438740] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-render [469.442800] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [469.541560] [120/156] (554s left) gem_eio (reset-stress) [469.776963] Starting subtest: reset-stress [469.779268] Starting dynamic subtest: render [474.769446] Dynamic subtest render: SUCCESS (4.936s) [474.787693] Starting dynamic subtest: bsd1 [492.426212] Dynamic subtest bsd1: SUCCESS (17.597s) [492.444263] Starting dynamic subtest: bsd2 [510.460049] Dynamic subtest bsd2: SUCCESS (18.031s) [510.476347] Starting dynamic subtest: blt [510.481017] Dynamic subtest blt: SKIP (0.000s) [510.490770] Starting dynamic subtest: vebox [528.421606] Dynamic subtest vebox: SUCCESS (17.956s) [528.424095] Subtest reset-stress: SUCCESS (58.525s) [529.933273] [121/156] (494s left) kms_big_fb (linear-64bpp-rotate-0) [530.032863] Starting subtest: linear-64bpp-rotate-0 [531.600675] Subtest linear-64bpp-rotate-0: SUCCESS (1.568s) [531.782424] [122/156] (492s left) gem_pxp (reject-modify-context-protection-off-1) [531.902214] Starting subtest: reject-modify-context-protection-off-1 [531.904794] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s) [532.020382] [123/156] (492s left) i915_pm_rps (min-max-config-idle) [532.084915] Starting subtest: min-max-config-idle [532.089578] Subtest min-max-config-idle: SKIP (0.001s) [532.193138] [124/156] (492s left) kms_flip_scaled_crc (flip-32bpp-ytileccs-to-64bpp-ytile-downscaling) [532.289534] Starting subtest: flip-32bpp-ytileccs-to-64bpp-ytile-downscaling [532.294087] Subtest flip-32bpp-ytileccs-to-64bpp-ytile-downscaling: SKIP (0.000s) [532.367306] [125/156] (492s left) kms_getfb (getfb-handle-valid) [532.466420] Starting subtest: getfb-handle-valid [532.468715] Subtest getfb-handle-valid: SUCCESS (0.000s) [532.568966] [126/156] (491s left) syncobj_wait (wait-for-submit-delayed-submit) [532.617444] Starting subtest: wait-for-submit-delayed-submit [532.719197] Subtest wait-for-submit-delayed-submit: SUCCESS (0.103s) [532.800967] [127/156] (491s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render) [532.899178] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render [539.745255] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.848s) [539.859071] [128/156] (484s left) kms_frontbuffer_tracking (fbcpsr-tiling-linear) [539.955428] Starting subtest: fbcpsr-tiling-linear [546.631674] Subtest fbcpsr-tiling-linear: SUCCESS (6.679s) [546.770482] [129/156] (477s left) syncobj_wait (single-wait-for-submit-submitted) [546.835744] Starting subtest: single-wait-for-submit-submitted [546.944774] Subtest single-wait-for-submit-submitted: SUCCESS (0.108s) [547.047968] [130/156] (477s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted-signaled) [547.100985] Starting subtest: multi-wait-available-unsubmitted-submitted-signaled [547.103361] Subtest multi-wait-available-unsubmitted-submitted-signaled: SUCCESS (0.000s) [547.196068] [131/156] (477s left) tools_test (tools_test) [547.248943] Starting subtest: tools_test [547.298883] Subtest tools_test: SUCCESS (0.066s) [547.360317] [132/156] (477s left) syncobj_eventfd (binary-wait-before-signal) [547.426146] Starting subtest: binary-wait-before-signal [547.456958] Subtest binary-wait-before-signal: SUCCESS (0.031s) [547.540102] [133/156] (477s left) kms_big_fb (4-tiled-64bpp-rotate-90) [547.647317] Starting subtest: 4-tiled-64bpp-rotate-90 [547.668000] Subtest 4-tiled-64bpp-rotate-90: SKIP (0.020s) [547.795237] [134/156] (477s left) gem_lmem_swapping (smem-oom) [547.836786] Subtest smem-oom: SKIP (0.000s) [547.879532] [135/156] (476s left) kms_frontbuffer_tracking (hdr-1p-primscrn-shrfb-msflip-blt) [547.975412] Starting subtest: hdr-1p-primscrn-shrfb-msflip-blt [547.979169] Subtest hdr-1p-primscrn-shrfb-msflip-blt: SKIP (0.000s) [548.081702] [136/156] (476s left) kms_legacy_colorkey (invalid-plane) [548.180871] Starting subtest: invalid-plane [548.182771] Starting dynamic subtest: zero-id [548.184552] Dynamic subtest zero-id: SUCCESS (0.000s) [548.194908] Starting dynamic subtest: outrange-id [548.196747] Dynamic subtest outrange-id: SUCCESS (0.000s) [548.198308] Subtest invalid-plane: SUCCESS (0.001s) [548.254102] [137/156] (476s left) syncobj_wait (multi-wait-for-submit-signaled) [548.313108] Starting subtest: multi-wait-for-submit-signaled [548.315194] Subtest multi-wait-for-submit-signaled: SUCCESS (0.000s) [548.421176] [138/156] (476s left) kms_big_fb (x-tiled-addfb) [548.522309] Starting subtest: x-tiled-addfb [548.524382] Subtest x-tiled-addfb: SUCCESS (0.000s) [548.622150] [139/156] (476s left) gem_ccs (block-copy-compressed) [548.675352] Starting subtest: block-copy-compressed [548.678918] Subtest block-copy-compressed: SKIP (0.000s) [548.780049] [140/156] (476s left) kms_properties (colorop-properties-legacy) [548.860618] Starting subtest: colorop-properties-legacy [548.862279] Starting dynamic subtest: pipe-A-eDP-1 [549.217733] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.358s) [549.230049] Starting dynamic subtest: pipe-B-eDP-1 [550.335893] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.115s) [550.346702] Starting dynamic subtest: pipe-C-eDP-1 [551.369118] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.033s) [551.381340] Starting dynamic subtest: pipe-D-eDP-1 [552.423745] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.053s) [552.426049] Subtest colorop-properties-legacy: SUCCESS (3.564s) [553.235946] [141/156] (471s left) gem_mmap_gtt (basic-small-bo) [553.292444] Subtest basic-small-bo: SKIP (0.000s) [553.368144] [142/156] (471s left) kms_flip (basic-flip-vs-wf_vblank) [553.465473] Starting subtest: basic-flip-vs-wf_vblank [553.467412] Starting dynamic subtest: A-eDP1 [555.392672] Dynamic subtest A-eDP1: SUCCESS (1.928s) [555.405911] Starting dynamic subtest: B-eDP1 [557.323444] Dynamic subtest B-eDP1: SUCCESS (1.928s) [557.336861] Starting dynamic subtest: C-eDP1 [559.250593] Dynamic subtest C-eDP1: SUCCESS (1.925s) [559.261755] Starting dynamic subtest: D-eDP1 [561.181042] Dynamic subtest D-eDP1: SUCCESS (1.929s) [561.183527] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.719s) [562.403939] [143/156] (462s left) syncobj_timeline (invalid-signal-one-illegal-handle) [562.453642] Starting subtest: invalid-signal-one-illegal-handle [562.455950] Subtest invalid-signal-one-illegal-handle: SUCCESS (0.000s) [562.552497] [144/156] (462s left) i915_hangman (gt-engine-error) [562.619036] Starting subtest: gt-engine-error [562.621242] Starting dynamic subtest: rcs0 [563.845396] Dynamic subtest rcs0: SUCCESS (1.226s) [563.857162] Starting dynamic subtest: bcs0 [565.890745] Dynamic subtest bcs0: SUCCESS (2.043s) [565.903829] Starting dynamic subtest: vcs0 [567.874962] Dynamic subtest vcs0: SUCCESS (1.982s) [567.891820] Starting dynamic subtest: vcs1 [569.860365] Dynamic subtest vcs1: SUCCESS (1.983s) [569.873212] Starting dynamic subtest: vecs0 [571.843909] Dynamic subtest vecs0: SUCCESS (1.981s) [571.859039] Starting dynamic subtest: ccs0 [573.891151] Dynamic subtest ccs0: SUCCESS (2.045s) [573.894088] Subtest gt-engine-error: SUCCESS (11.277s) [573.978709] [145/156] (451s left) kms_psr (psr-cursor-plane-move) [574.074924] Starting subtest: psr-cursor-plane-move [574.077142] Starting dynamic subtest: eDP-1 [575.795659] Dynamic subtest eDP-1: SUCCESS (1.722s) [575.798178] Subtest psr-cursor-plane-move: SUCCESS (1.723s) [576.664414] [146/156] (448s left) sw_sync (sync_merge_invalid) [576.700398] Starting subtest: sync_merge_invalid [576.723842] Subtest sync_merge_invalid: SUCCESS (0.021s) [576.791807] [147/156] (448s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-cur-indfb-onoff) [576.887853] Starting subtest: psrhdr-2p-scndscrn-cur-indfb-onoff [576.892402] Subtest psrhdr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s) [576.981019] [148/156] (448s left) vgem_basic (dmabuf-export) [577.033523] Starting subtest: dmabuf-export [577.051962] Subtest dmabuf-export: SUCCESS (0.023s) [577.163511] [149/156] (448s left) gem_exec_balancer (busy) [577.226415] Starting subtest: busy [578.909926] Subtest busy: SUCCESS (1.684s) [579.220195] [150/156] (446s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-spr-indfb-onoff) [579.318895] Starting subtest: fbcpsrhdr-1p-primscrn-spr-indfb-onoff [579.322996] Subtest fbcpsrhdr-1p-primscrn-spr-indfb-onoff: SKIP (0.000s) [579.408094] [151/156] (446s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt) [579.508077] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt [579.512496] Subtest fbc-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [579.597811] [152/156] (445s left) gem_partial_pwrite_pread (reads-uncached) [579.655372] Subtest reads-uncached: SKIP (0.000s) [579.719579] [153/156] (445s left) perf_pmu (render-node-busy) [579.803202] Starting subtest: render-node-busy [579.805641] Starting dynamic subtest: rcs0 [580.402938] Dynamic subtest rcs0: SUCCESS (0.603s) [580.416569] Starting dynamic subtest: bcs0 [580.967526] Dynamic subtest bcs0: SUCCESS (0.562s) [580.981350] Starting dynamic subtest: vcs0 [582.884572] Dynamic subtest vcs0: SUCCESS (1.914s) [582.898144] Starting dynamic subtest: vcs1 [584.868905] Dynamic subtest vcs1: SUCCESS (1.982s) [584.882212] Starting dynamic subtest: vecs0 [586.916285] Dynamic subtest vecs0: SUCCESS (2.045s) [586.930191] Starting dynamic subtest: ccs0 [587.489274] Dynamic subtest ccs0: SUCCESS (0.572s) [587.491710] Subtest render-node-busy: SUCCESS (7.691s) [587.569600] [154/156] (438s left) kms_frontbuffer_tracking (fbchdr-2p-shrfb-fliptrack-mmap-gtt) [587.663760] Starting subtest: fbchdr-2p-shrfb-fliptrack-mmap-gtt [587.667984] Subtest fbchdr-2p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s) [587.758711] [155/156] (437s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-wc) [587.861214] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-wc [587.865654] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [587.983309] [156/156] (437s left) gem_ctx_param (vm) [588.028180] Starting subtest: vm [588.077698] Subtest vm: SUCCESS (0.049s) [588.203557] Closing watchdogs results: parsing output: 0/ for test: kms_vblank results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_plane_scaling results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: sysfs_preempt_timeout results: parsing output: 5/ for test: gem_exec_reloc results: parsing output: 6/ for test: kms_cursor_crc results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: gem_gpgpu_fill results: parsing output: 9/ for test: syncobj_timeline results: parsing output: 10/ for test: gem_exec_capture results: parsing output: 11/ for test: gem_ctx_persistence results: parsing output: 12/ for test: syncobj_wait results: parsing output: 13/ for test: kms_frontbuffer_tracking results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_exec_reloc results: parsing output: 16/ for test: kms_plane results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_universal_plane results: parsing output: 19/ for test: kms_psr results: parsing output: 20/ for test: i915_selftest results: parsing output: 21/ for test: kms_joiner results: parsing output: 22/ for test: kms_addfb_basic results: parsing output: 23/ for test: kms_psr results: parsing output: 24/ for test: gen3_mixed_blits results: parsing output: 25/ for test: kms_cursor_legacy results: parsing output: 26/ for test: syncobj_wait results: parsing output: 27/ for test: syncobj_wait results: parsing output: 28/ for test: kms_flip_scaled_crc results: parsing output: 29/ for test: kms_frontbuffer_tracking results: parsing output: 30/ for test: kms_flip_scaled_crc results: parsing output: 31/ for test: kms_cursor_legacy results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: kms_chamelium_frames results: parsing output: 35/ for test: gem_exec_schedule results: parsing output: 36/ for test: kms_content_protection results: parsing output: 37/ for test: i915_drm_fdinfo results: parsing output: 38/ for test: kms_ccs results: parsing output: 39/ for test: kms_plane_scaling results: parsing output: 40/ for test: gem_exec_flush results: parsing output: 41/ for test: kms_cursor_crc results: parsing output: 42/ for test: kms_big_fb results: parsing output: 43/ for test: syncobj_eventfd results: parsing output: 44/ for test: gem_mmap_offset results: parsing output: 45/ for test: kms_psr results: parsing output: 46/ for test: gem_workarounds results: parsing output: 47/ for test: kms_flip results: parsing output: 48/ for test: kms_plane results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: kms_pm_rpm results: parsing output: 51/ for test: gem_exec_whisper results: parsing output: 52/ for test: perf results: parsing output: 53/ for test: kms_frontbuffer_tracking results: parsing output: 54/ for test: kms_rotation_crc results: parsing output: 55/ for test: gem_ctx_shared results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_frontbuffer_tracking results: parsing output: 58/ for test: gem_tiling_max_stride results: parsing output: 59/ for test: gem_softpin results: parsing output: 60/ for test: kms_atomic results: parsing output: 61/ for test: kms_async_flips results: parsing output: 62/ for test: gem_render_copy results: parsing output: 63/ for test: kms_ccs results: parsing output: 64/ for test: gem_sync results: parsing output: 65/ for test: api_intel_bb results: parsing output: 66/ for test: kms_big_fb results: parsing output: 67/ for test: gem_pwrite results: parsing output: 68/ for test: kms_draw_crc results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_plane_lowres results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: gem_watchdog results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: gem_exec_fence results: parsing output: 75/ for test: kms_psr2_sf results: parsing output: 76/ for test: kms_ccs results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: kms_frontbuffer_tracking results: parsing output: 79/ for test: api_intel_allocator results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: gem_exec_params results: parsing output: 83/ for test: gem_userptr_blits results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: kms_psr results: parsing output: 86/ for test: kms_frontbuffer_tracking results: parsing output: 87/ for test: kms_big_fb results: parsing output: 88/ for test: kms_flip results: parsing output: 89/ for test: gen9_exec_parse results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_chamelium_hpd results: parsing output: 92/ for test: kms_frontbuffer_tracking results: parsing output: 93/ for test: kms_frontbuffer_tracking results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_busy results: parsing output: 96/ for test: kms_cursor_legacy results: parsing output: 97/ for test: kms_color_pipeline results: parsing output: 98/ for test: kms_frontbuffer_tracking results: parsing output: 99/ for test: kms_cursor_crc results: parsing output: 100/ for test: syncobj_timeline results: parsing output: 101/ for test: kms_ccs results: parsing output: 102/ for test: kms_psr results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_userptr_blits results: parsing output: 105/ for test: kms_frontbuffer_tracking results: parsing output: 106/ for test: kms_frontbuffer_tracking results: parsing output: 107/ for test: gem_exec_schedule results: parsing output: 108/ for test: kms_cursor_legacy results: parsing output: 109/ for test: device_reset results: parsing output: 110/ for test: kms_frontbuffer_tracking results: parsing output: 111/ for test: kms_flip results: parsing output: 112/ for test: gem_compute results: parsing output: 113/ for test: kms_getfb results: parsing output: 114/ for test: kms_pm_rpm results: parsing output: 115/ for test: gem_exec_fence results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: gem_mmap results: parsing output: 118/ for test: kms_frontbuffer_tracking results: parsing output: 119/ for test: gem_eio results: parsing output: 120/ for test: kms_big_fb results: parsing output: 121/ for test: gem_pxp results: parsing output: 122/ for test: i915_pm_rps results: parsing output: 123/ for test: kms_flip_scaled_crc results: parsing output: 124/ for test: kms_getfb results: parsing output: 125/ for test: syncobj_wait results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: syncobj_wait results: parsing output: 129/ for test: syncobj_timeline results: parsing output: 130/ for test: tools_test results: parsing output: 131/ for test: syncobj_eventfd results: parsing output: 132/ for test: kms_big_fb results: parsing output: 133/ for test: gem_lmem_swapping results: parsing output: 134/ for test: kms_frontbuffer_tracking results: parsing output: 135/ for test: kms_legacy_colorkey results: parsing output: 136/ for test: syncobj_wait results: parsing output: 137/ for test: kms_big_fb results: parsing output: 138/ for test: gem_ccs results: parsing output: 139/ for test: kms_properties results: parsing output: 140/ for test: gem_mmap_gtt results: parsing output: 141/ for test: kms_flip results: parsing output: 142/ for test: syncobj_timeline results: parsing output: 143/ for test: i915_hangman results: parsing output: 144/ for test: kms_psr results: parsing output: 145/ for test: sw_sync results: parsing output: 146/ for test: kms_frontbuffer_tracking results: parsing output: 147/ for test: vgem_basic results: parsing output: 148/ for test: gem_exec_balancer results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_frontbuffer_tracking results: parsing output: 151/ for test: gem_partial_pwrite_pread results: parsing output: 152/ for test: perf_pmu results: parsing output: 153/ for test: kms_frontbuffer_tracking results: parsing output: 154/ for test: kms_frontbuffer_tracking results: parsing output: 155/ for test: gem_ctx_param Done.