[74.943990] Initializing watchdogs [74.944056] /dev/watchdog0 [74.958987] [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] [74.963641] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [74.966063] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [74.969392] [001/156] (960s left) kms_vblank (wait-forked-busy) [75.102111] Starting subtest: wait-forked-busy [75.104384] Starting dynamic subtest: pipe-A-eDP-1 [77.007184] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.905s) [77.021205] Starting dynamic subtest: pipe-D-eDP-1 [79.562490] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.552s) [79.564876] Subtest wait-forked-busy: SUCCESS (4.460s) [80.448434] [002/156] (955s left) gem_ppgtt (flink-and-close-vma-leak) [80.530875] Starting subtest: flink-and-close-vma-leak [80.572190] Subtest flink-and-close-vma-leak: SUCCESS (0.044s) [80.705134] [003/156] (954s left) kms_cursor_crc (cursor-sliding-32x32) [80.868748] Starting subtest: cursor-sliding-32x32 [80.920319] Subtest cursor-sliding-32x32: SKIP (0.047s) [81.194661] [004/156] (954s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-spr-indfb-draw-pwrite) [81.292836] Starting subtest: psrhdr-1p-primscrn-spr-indfb-draw-pwrite [81.297403] Subtest psrhdr-1p-primscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [81.382347] [005/156] (954s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-hflip) [81.474268] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-hflip [82.608600] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-hflip: SUCCESS (1.134s) [82.759072] [006/156] (952s left) kms_chamelium_hpd (vga-hpd-for-each-pipe) [83.188613] Subtest vga-hpd-for-each-pipe: SKIP (0.000s) [84.175276] [007/156] (951s left) kms_flip (nonexisting-fb) [84.277829] Starting subtest: nonexisting-fb [84.280320] Starting dynamic subtest: A-eDP1 [85.490846] Dynamic subtest A-eDP1: SUCCESS (1.212s) [85.499256] Starting dynamic subtest: B-eDP1 [86.617662] Dynamic subtest B-eDP1: SUCCESS (1.126s) [86.626493] Starting dynamic subtest: C-eDP1 [87.755813] Dynamic subtest C-eDP1: SUCCESS (1.136s) [87.765132] Starting dynamic subtest: D-eDP1 [88.890622] Dynamic subtest D-eDP1: SUCCESS (1.133s) [88.893058] Subtest nonexisting-fb: SUCCESS (4.617s) [90.086442] [008/156] (945s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [90.193565] Starting subtest: fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt [90.197979] Subtest fbchdr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [90.285024] [009/156] (945s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt) [90.384456] Starting subtest: fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt [90.388594] Subtest fbcpsrhdr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [90.476905] [010/156] (945s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-shrfb-plflip-blt) [90.574567] Starting subtest: fbcpsr-1p-primscrn-shrfb-plflip-blt [98.107931] Subtest fbcpsr-1p-primscrn-shrfb-plflip-blt: SUCCESS (7.540s) [98.255939] [011/156] (937s left) kms_prop_blob (blob-prop-lifetime) [98.310816] Starting subtest: blob-prop-lifetime [98.313095] Subtest blob-prop-lifetime: SUCCESS (0.001s) [98.433667] [012/156] (937s left) kms_ccs (crc-primary-basic-4-tiled-bmg-ccs) [98.535029] Starting subtest: crc-primary-basic-4-tiled-bmg-ccs [98.539874] Subtest crc-primary-basic-4-tiled-bmg-ccs: SKIP (0.000s) [99.687698] [013/156] (936s left) gem_exec_params (invalid-bsd1-flag-on-render) [99.752944] Starting subtest: invalid-bsd1-flag-on-render [99.755354] Subtest invalid-bsd1-flag-on-render: SUCCESS (0.000s) [99.844799] [014/156] (936s left) sw_sync (sync_multi_timeline_wait) [99.878562] Starting subtest: sync_multi_timeline_wait [99.880917] Subtest sync_multi_timeline_wait: SUCCESS (0.001s) [99.935191] [015/156] (936s left) kms_frontbuffer_tracking (fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt) [100.037980] Starting subtest: fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt [100.042258] Subtest fbchdr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [100.138303] [016/156] (935s left) kms_big_fb (x-tiled-64bpp-rotate-180) [100.241764] Starting subtest: x-tiled-64bpp-rotate-180 [101.843625] Subtest x-tiled-64bpp-rotate-180: SUCCESS (1.602s) [102.019937] [017/156] (934s left) gem_softpin (noreloc) [102.084591] Starting subtest: noreloc [107.528560] Subtest noreloc: SUCCESS (5.390s) [107.599585] [018/156] (928s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc) [107.701778] Starting subtest: psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc [107.706243] Subtest psrhdr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [107.796971] [019/156] (928s left) kms_cursor_legacy (single-bo) [107.918152] Starting subtest: single-bo [107.920443] Starting dynamic subtest: pipe-A [113.352680] Dynamic subtest pipe-A: SUCCESS (5.379s) [113.363278] Starting dynamic subtest: pipe-B [118.735059] Dynamic subtest pipe-B: SUCCESS (5.380s) [118.745505] Starting dynamic subtest: pipe-C [124.117667] Dynamic subtest pipe-C: SUCCESS (5.380s) [124.127653] Starting dynamic subtest: pipe-D [129.499204] Dynamic subtest pipe-D: SUCCESS (5.380s) [129.509298] Starting dynamic subtest: all-pipes [134.888599] Dynamic subtest all-pipes: SUCCESS (5.387s) [134.890822] Subtest single-bo: SUCCESS (26.913s) [134.979426] [020/156] (901s left) kms_lease (lease-invalid-crtc) [135.069853] Starting subtest: lease-invalid-crtc [135.072162] Starting dynamic subtest: pipe-A-eDP-1 [135.074491] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [135.084338] Starting dynamic subtest: pipe-B-eDP-1 [135.086192] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [135.094120] Starting dynamic subtest: pipe-C-eDP-1 [135.096342] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [135.104559] Starting dynamic subtest: pipe-D-eDP-1 [135.106850] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [135.109115] Subtest lease-invalid-crtc: SUCCESS (0.003s) [135.144441] [021/156] (901s left) kms_lease (atomic-implicit-crtc) [135.232832] Starting subtest: atomic-implicit-crtc [135.235103] Starting dynamic subtest: pipe-A-eDP-1 [135.246571] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [135.255833] Starting dynamic subtest: pipe-B-eDP-1 [135.266910] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.010s) [135.275438] Starting dynamic subtest: pipe-C-eDP-1 [135.285733] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.011s) [135.293636] Starting dynamic subtest: pipe-D-eDP-1 [135.304189] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.010s) [135.306050] Subtest atomic-implicit-crtc: SUCCESS (0.036s) [135.385603] [022/156] (900s left) kms_frontbuffer_tracking (fbchdr-2p-primscrn-cur-indfb-onoff) [135.484759] Starting subtest: fbchdr-2p-primscrn-cur-indfb-onoff [135.489139] Subtest fbchdr-2p-primscrn-cur-indfb-onoff: SKIP (0.000s) [135.578623] [023/156] (900s left) kms_busy (extended-pageflip-hang-oldfb) [135.683696] Starting subtest: extended-pageflip-hang-oldfb [135.685943] Starting dynamic subtest: pipe-A [136.102746] Dynamic subtest pipe-A: SUCCESS (0.417s) [136.111653] Starting dynamic subtest: pipe-D [137.273441] Dynamic subtest pipe-D: SUCCESS (1.170s) [137.275902] Subtest extended-pageflip-hang-oldfb: SUCCESS (1.591s) [138.115147] [024/156] (898s left) prime_vgem (fence-flip-hang) [138.250458] Subtest fence-flip-hang: SKIP (0.000s) [138.349711] [FACT prime_vgem (fence-flip-hang)] new: kernel.kmod_is_loaded.vgem: true [138.352900] [025/156] (898s left) gem_userptr_blits (coherency-unsync) [138.426269] Subtest coherency-unsync: SKIP (0.000s) [138.559012] [026/156] (897s left) gem_spin_batch (resubmit-new-all) [138.619974] Starting subtest: resubmit-new-all [138.622286] Starting dynamic subtest: rcs0 [138.635612] Dynamic subtest rcs0: SUCCESS (0.018s) [138.646565] Starting dynamic subtest: bcs0 [138.648914] Dynamic subtest bcs0: SUCCESS (0.010s) [138.657518] Starting dynamic subtest: vcs0 [138.659454] Dynamic subtest vcs0: SUCCESS (0.010s) [138.668067] Starting dynamic subtest: vcs1 [138.670297] Dynamic subtest vcs1: SUCCESS (0.008s) [138.678846] Starting dynamic subtest: vecs0 [138.680810] Dynamic subtest vecs0: SUCCESS (0.008s) [138.689430] Starting dynamic subtest: ccs0 [138.691702] Dynamic subtest ccs0: SUCCESS (0.008s) [138.693966] Subtest resubmit-new-all: SUCCESS (0.065s) [140.342572] [027/156] (896s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [140.447304] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [141.502963] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.057s) [141.627987] [028/156] (894s left) kms_cursor_legacy (2x-cursor-vs-flip-atomic) [141.749535] Starting subtest: 2x-cursor-vs-flip-atomic [141.753374] Subtest 2x-cursor-vs-flip-atomic: SKIP (0.001s) [141.895106] [029/156] (894s left) gem_exec_fence (syncobj-unused-fence) [142.321681] Starting subtest: syncobj-unused-fence [142.326977] Subtest syncobj-unused-fence: SUCCESS (0.005s) [143.380114] [030/156] (893s left) perf_pmu (interrupts-sync) [143.423595] Starting subtest: interrupts-sync [144.507099] Subtest interrupts-sync: SUCCESS (1.084s) [144.620748] [031/156] (892s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite) [144.728894] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite [151.663083] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.940s) [151.772513] [032/156] (884s left) kms_getfb (getfb-reject-nv12) [151.867119] Starting subtest: getfb-reject-nv12 [151.869433] Subtest getfb-reject-nv12: SUCCESS (0.001s) [151.973752] [033/156] (884s left) kms_cursor_legacy (flip-vs-cursor-toggle) [152.108697] Starting subtest: flip-vs-cursor-toggle [161.145773] Subtest flip-vs-cursor-toggle: SUCCESS (9.036s) [162.042990] [034/156] (874s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled) [162.098390] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [162.100860] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [162.214659] [035/156] (874s left) kms_async_flips (test-cursor-atomic) [162.321858] Starting subtest: test-cursor-atomic [162.696759] Starting dynamic subtest: pipe-A-eDP-1 [163.526278] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s) [163.920831] Starting dynamic subtest: pipe-B-eDP-1 [164.676377] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s) [165.055739] Starting dynamic subtest: pipe-C-eDP-1 [165.813339] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.765s) [166.181117] Starting dynamic subtest: pipe-D-eDP-1 [166.938053] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.766s) [166.940431] Subtest test-cursor-atomic: SUCCESS (4.619s) [168.110684] [036/156] (868s left) gem_exec_schedule (u-fairslice) [168.187206] Starting subtest: u-fairslice [168.189130] Starting dynamic subtest: rcs0 [170.251951] Dynamic subtest rcs0: SUCCESS (2.020s) [170.262873] Starting dynamic subtest: bcs0 [172.219896] Dynamic subtest bcs0: SUCCESS (2.018s) [172.229742] Starting dynamic subtest: vcs0 [174.287979] Dynamic subtest vcs0: SUCCESS (2.020s) [174.298916] Starting dynamic subtest: vcs1 [176.265813] Dynamic subtest vcs1: SUCCESS (2.023s) [176.276553] Starting dynamic subtest: vecs0 [178.332342] Dynamic subtest vecs0: SUCCESS (2.017s) [178.345936] Starting dynamic subtest: ccs0 [180.304383] Dynamic subtest ccs0: SUCCESS (2.021s) [180.306696] Subtest u-fairslice: SUCCESS (12.123s) [180.603169] [037/156] (856s left) kms_draw_crc (draw-method-mmap-gtt) [180.697399] Starting subtest: draw-method-mmap-gtt [180.701722] Subtest draw-method-mmap-gtt: SKIP (0.000s) [180.806067] [038/156] (856s left) sriov_basic (enable-vfs-bind-unbind-each-numvfs-all) [180.863324] Starting subtest: enable-vfs-bind-unbind-each-numvfs-all [180.937107] Subtest enable-vfs-bind-unbind-each-numvfs-all: FAIL (0.013s) [180.974574] [039/156] (856s left) gen9_exec_parse (bb-secure) [181.038404] Subtest bb-secure: SKIP (0.000s) [181.118633] [040/156] (855s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [181.211329] Starting subtest: fbc-indfb-scaledprimary [184.130775] Subtest fbc-indfb-scaledprimary: SUCCESS (2.924s) [185.355290] [041/156] (851s left) gem_exec_schedule (wide) [185.554756] Starting subtest: wide [185.556779] Starting dynamic subtest: rcs0 [195.670395] Dynamic subtest rcs0: SUCCESS (10.062s) [195.685216] Starting dynamic subtest: vcs0 [205.811302] Dynamic subtest vcs0: SUCCESS (10.191s) [205.823168] Starting dynamic subtest: vcs1 [217.704595] Dynamic subtest vcs1: SUCCESS (11.892s) [217.715766] Starting dynamic subtest: vecs0 [229.456090] Dynamic subtest vecs0: SUCCESS (11.750s) [229.465810] Starting dynamic subtest: ccs0 [244.088288] Dynamic subtest ccs0: SUCCESS (14.579s) [244.090297] Subtest wide: SUCCESS (58.480s) [245.449148] [042/156] (791s left) kms_plane (pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping) [245.547630] Starting subtest: pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping [245.551825] Subtest pixel-format-4-tiled-dg2-mc-ccs-modifier-source-clamping: SKIP (0.000s) [245.619986] [043/156] (791s left) kms_pm_dc (dc5-dpms) [246.719889] Starting subtest: dc5-dpms [248.803851] Subtest dc5-dpms: SUCCESS (2.083s) [248.884242] [044/156] (788s left) gem_exec_schedule (preempt-queue-chain) [248.963676] Subtest preempt-queue-chain: SKIP (0.000s) [249.266948] [045/156] (788s left) kms_flip (2x-nonexisting-fb-interruptible) [249.367294] Starting subtest: 2x-nonexisting-fb-interruptible [249.382574] Subtest 2x-nonexisting-fb-interruptible: SKIP (0.013s) [249.473347] [046/156] (787s left) perf_pmu (init-wait) [249.511538] Starting subtest: init-wait [249.513717] Starting dynamic subtest: rcs0 [249.515934] Dynamic subtest rcs0: SUCCESS (0.002s) [249.525584] Starting dynamic subtest: bcs0 [249.527495] Dynamic subtest bcs0: SUCCESS (0.000s) [249.536660] Starting dynamic subtest: vcs0 [249.538568] Dynamic subtest vcs0: SUCCESS (0.001s) [249.547302] Starting dynamic subtest: vcs1 [249.549167] Dynamic subtest vcs1: SUCCESS (0.001s) [249.557842] Starting dynamic subtest: vecs0 [249.559779] Dynamic subtest vecs0: SUCCESS (0.000s) [249.568973] Starting dynamic subtest: ccs0 [249.571175] Dynamic subtest ccs0: SUCCESS (0.000s) [249.573364] Subtest init-wait: SUCCESS (0.007s) [249.620793] [047/156] (787s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-fullscreen) [249.718083] Starting subtest: fbc-2p-scndscrn-spr-indfb-fullscreen [249.722651] Subtest fbc-2p-scndscrn-spr-indfb-fullscreen: SKIP (0.000s) [249.811445] [048/156] (787s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [249.914132] Starting subtest: fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu [249.918714] Subtest fbcpsrhdr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [250.027549] [049/156] (787s left) vgem_slow (nohang) [250.075264] Starting subtest: nohang [260.623787] Subtest nohang: SUCCESS (10.496s) [260.663557] [050/156] (776s left) kms_ccs (crc-primary-suspend-4-tiled-dg2-mc-ccs) [260.763169] Starting subtest: crc-primary-suspend-4-tiled-dg2-mc-ccs [260.765540] Starting dynamic subtest: pipe-A-eDP-1 [260.774725] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [260.785815] Starting dynamic subtest: pipe-B-eDP-1 [260.795026] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [260.806681] Starting dynamic subtest: pipe-C-eDP-1 [260.815330] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [260.825300] Starting dynamic subtest: pipe-D-eDP-1 [260.834233] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [260.838587] Subtest crc-primary-suspend-4-tiled-dg2-mc-ccs: SKIP (0.004s) [263.032923] [051/156] (774s left) gem_ctx_shared (q-independent) [263.103227] Starting subtest: Q-independent [263.105575] Starting dynamic subtest: rcs0 [263.173040] Dynamic subtest rcs0: SUCCESS (0.069s) [263.190874] Starting dynamic subtest: vcs0 [263.223117] Dynamic subtest vcs0: SUCCESS (0.049s) [263.236160] Starting dynamic subtest: vcs1 [263.267390] Dynamic subtest vcs1: SUCCESS (0.044s) [263.279152] Starting dynamic subtest: vecs0 [263.307856] Dynamic subtest vecs0: SUCCESS (0.040s) [263.318618] Starting dynamic subtest: ccs0 [263.355583] Dynamic subtest ccs0: SUCCESS (0.047s) [263.358066] Subtest Q-independent: SUCCESS (0.252s) [264.336472] [052/156] (773s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-mmap-gtt) [264.435618] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-mmap-gtt [264.440067] Subtest fbc-2p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [264.534242] [053/156] (773s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-move) [264.648672] Starting subtest: psr-2p-primscrn-spr-indfb-move [264.652956] Subtest psr-2p-primscrn-spr-indfb-move: SKIP (0.000s) [264.735689] [054/156] (772s left) gem_pxp (create-regular-context-1) [264.871694] Starting subtest: create-regular-context-1 [264.873739] Subtest create-regular-context-1: SUCCESS (0.001s) [264.989693] [055/156] (772s left) kms_frontbuffer_tracking (hdr-2p-primscrn-cur-indfb-draw-render) [265.085744] Starting subtest: hdr-2p-primscrn-cur-indfb-draw-render [265.090073] Subtest hdr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [265.203603] [056/156] (772s left) gem_render_copy (y-tiled-to-vebox-y-tiled) [265.255075] Starting subtest: y-tiled-to-vebox-y-tiled [265.259511] Subtest y-tiled-to-vebox-y-tiled: SKIP (0.000s) [265.453503] [057/156] (772s left) kms_frontbuffer_tracking (hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu) [265.563023] Starting subtest: hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu [265.567570] Subtest hdr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s) [265.702682] [058/156] (772s left) kms_big_fb (y-tiled-32bpp-rotate-180) [265.809347] Starting subtest: y-tiled-32bpp-rotate-180 [265.813824] Subtest y-tiled-32bpp-rotate-180: SKIP (0.000s) [265.920142] [059/156] (771s left) kms_frontbuffer_tracking (fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt) [266.025101] Starting subtest: fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt [266.029229] Subtest fbcpsrhdr-1p-primscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [266.132436] [060/156] (771s left) gem_exec_balancer (parallel-dmabuf-import-out-fence) [266.397868] Starting subtest: parallel-dmabuf-import-out-fence [267.533418] Subtest parallel-dmabuf-import-out-fence: SUCCESS (1.135s) [267.649321] [061/156] (770s left) gem_exec_balancer (nohangcheck) [267.919671] Starting subtest: nohangcheck [268.865887] Subtest nohangcheck: SUCCESS (0.947s) [269.010116] [062/156] (768s left) kms_selftest (drm_format_helper) [269.045830] Starting subtest: drm_format_helper [269.089760] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8 [269.213514] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_gray8: SUCCESS (0.125s) [269.222862] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332 [269.311174] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb332: SUCCESS (0.098s) [269.320808] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565 [269.454062] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb565: SUCCESS (0.141s) [269.463949] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555 [269.554275] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb1555: SUCCESS (0.100s) [269.563708] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555 [269.650591] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb1555: SUCCESS (0.095s) [269.661343] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551 [269.745241] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgba5551: SUCCESS (0.092s) [269.756481] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888 [269.868972] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_rgb888: SUCCESS (0.122s) [269.880606] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888 [269.979292] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_bgr888: SUCCESS (0.109s) [269.990883] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888 [270.082514] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb8888: SUCCESS (0.102s) [270.092848] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010 [270.194048] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xrgb2101010: SUCCESS (0.114s) [270.205048] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010 [270.286080] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_argb2101010: SUCCESS (0.089s) [270.297634] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_mono [270.379800] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_mono: SUCCESS (0.094s) [270.390085] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_swab [270.480212] Dynamic subtest drm_format_helper_test-drm_test_fb_swab: SUCCESS (0.096s) [270.489316] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888 [270.586879] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_xbgr8888: SUCCESS (0.106s) [270.596200] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888 [270.700891] Dynamic subtest drm_format_helper_test-drm_test_fb_xrgb8888_to_abgr8888: SUCCESS (0.113s) [270.711831] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_clip_offset [270.786844] Dynamic subtest drm_format_helper_test-drm_test_fb_clip_offset: SUCCESS (0.086s) [270.796398] Starting dynamic subtest: drm_format_helper_test-drm_test_fb_memcpy [270.905643] Dynamic subtest drm_format_helper_test-drm_test_fb_memcpy: SUCCESS (0.119s) [270.907543] Subtest drm_format_helper: SUCCESS (1.862s) [271.086023] [063/156] (766s left) kms_frontbuffer_tracking (fbcpsrhdr-tiling-y) [271.195464] Starting subtest: fbcpsrhdr-tiling-y [271.198904] Subtest fbcpsrhdr-tiling-y: SKIP (0.000s) [271.304948] [064/156] (766s left) kms_cursor_crc (cursor-sliding-128x42) [271.540922] Starting subtest: cursor-sliding-128x42 [271.591026] Subtest cursor-sliding-128x42: SKIP (0.046s) [271.770328] [065/156] (766s left) gem_render_copy (yf-tiled-ccs-to-y-tiled) [271.831391] Starting subtest: yf-tiled-ccs-to-y-tiled [271.835157] Subtest yf-tiled-ccs-to-y-tiled: SKIP (0.000s) [272.025596] [066/156] (766s left) gem_ctx_param (invalid-param-set) [272.081638] Starting subtest: invalid-param-set [272.084150] Subtest invalid-param-set: SUCCESS (0.000s) [272.166313] [067/156] (766s left) kms_plane_scaling (planes-upscale-20x20-downscale-factor-0-75) [272.256747] Starting subtest: planes-upscale-20x20-downscale-factor-0-75 [272.258999] Starting dynamic subtest: pipe-A [272.280614] Dynamic subtest pipe-A: SKIP (0.020s) [272.290538] Starting dynamic subtest: pipe-B [272.316693] Dynamic subtest pipe-B: SKIP (0.035s) [272.328425] Starting dynamic subtest: pipe-C [272.352788] Dynamic subtest pipe-C: SKIP (0.035s) [272.362296] Starting dynamic subtest: pipe-D [272.387107] Dynamic subtest pipe-D: SKIP (0.036s) [272.391253] Subtest planes-upscale-20x20-downscale-factor-0-75: SKIP (0.129s) [272.508826] [068/156] (765s left) kms_frontbuffer_tracking (fbc-farfromfence-mmap-gtt) [272.608186] Starting subtest: fbc-farfromfence-mmap-gtt [272.612501] Subtest fbc-farfromfence-mmap-gtt: SKIP (0.000s) [272.709575] [069/156] (765s left) gem_ctx_persistence (engines-queued) [272.765825] Starting subtest: engines-queued [272.768171] Starting dynamic subtest: rcs0 [272.831897] Dynamic subtest rcs0: SUCCESS (0.065s) [272.841588] Starting dynamic subtest: bcs0 [272.903653] Dynamic subtest bcs0: SUCCESS (0.071s) [272.915506] Starting dynamic subtest: vcs0 [274.271494] Dynamic subtest vcs0: SUCCESS (1.364s) [274.282667] Starting dynamic subtest: vcs1 [276.254368] Dynamic subtest vcs1: SUCCESS (1.980s) [276.267731] Starting dynamic subtest: vecs0 [278.290841] Dynamic subtest vecs0: SUCCESS (1.980s) [278.303545] Starting dynamic subtest: ccs0 [278.418647] Dynamic subtest ccs0: SUCCESS (0.181s) [278.421159] Subtest engines-queued: SUCCESS (5.653s) [278.539711] [070/156] (759s left) kms_frontbuffer_tracking (hdr-1p-primscrn-pri-shrfb-draw-render) [278.634401] Starting subtest: hdr-1p-primscrn-pri-shrfb-draw-render [278.639088] Subtest hdr-1p-primscrn-pri-shrfb-draw-render: SKIP (0.000s) [278.737396] [071/156] (759s left) i915_query (query-topology-matches-eu-total) [278.791779] Starting subtest: query-topology-matches-eu-total [278.794093] Subtest query-topology-matches-eu-total: SUCCESS (0.000s) [278.916102] [072/156] (759s left) kms_psr (psr-primary-render) [279.004655] Starting subtest: psr-primary-render [279.006753] Starting dynamic subtest: eDP-1 [280.732347] Dynamic subtest eDP-1: SUCCESS (1.727s) [280.734954] Subtest psr-primary-render: SUCCESS (1.729s) [281.584185] [073/156] (756s left) kms_chamelium_audio (hdmi-audio) [281.980795] Subtest hdmi-audio: SKIP (0.000s) [282.802320] [074/156] (755s left) gem_bad_reloc (negative-reloc) [282.859104] Subtest negative-reloc: SKIP (0.000s) [282.929283] [075/156] (755s left) kms_flip_scaled_crc (flip-32bpp-xtile-to-64bpp-xtile-downscaling) [283.025062] Starting subtest: flip-32bpp-xtile-to-64bpp-xtile-downscaling [283.027529] Starting dynamic subtest: pipe-A-default-mode [284.189758] Dynamic subtest pipe-A-default-mode: SKIP (1.163s) [284.193485] Subtest flip-32bpp-xtile-to-64bpp-xtile-downscaling: SKIP (1.164s) [284.347394] [076/156] (754s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-upscaling) [284.442570] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-upscaling [284.445257] Starting dynamic subtest: pipe-A-default-mode [287.182100] Dynamic subtest pipe-A-default-mode: SUCCESS (2.739s) [287.184389] Subtest flip-64bpp-xtile-to-32bpp-xtile-upscaling: SUCCESS (2.740s) [288.049211] [077/156] (750s left) kms_frontbuffer_tracking (psrhdr-1p-primscrn-indfb-pgflip-blt) [288.145463] Starting subtest: psrhdr-1p-primscrn-indfb-pgflip-blt [288.149650] Subtest psrhdr-1p-primscrn-indfb-pgflip-blt: SKIP (0.000s) [288.259512] [078/156] (750s left) core_setmaster (master-drop-set-root) [288.316266] Starting subtest: master-drop-set-root [288.341567] Subtest master-drop-set-root: SUCCESS (0.025s) [288.391584] [079/156] (750s left) kms_rmfb (close-fd) [288.473815] Starting subtest: close-fd [288.476070] Starting dynamic subtest: pipe-A-eDP-1 [288.582017] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.106s) [288.592848] Starting dynamic subtest: pipe-B-eDP-1 [289.811291] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.229s) [289.820999] Starting dynamic subtest: pipe-C-eDP-1 [291.029460] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.217s) [291.039516] Starting dynamic subtest: pipe-D-eDP-1 [292.179110] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.148s) [292.181381] Subtest close-fd: SUCCESS (3.706s) [293.389514] [080/156] (745s left) i915_pm_rps (basic-api) [293.456425] Starting subtest: basic-api [293.461304] Subtest basic-api: SKIP (0.001s) [293.584447] [081/156] (745s left) kms_frontbuffer_tracking (fbchdr-1p-pri-indfb-multidraw) [293.686790] Starting subtest: fbchdr-1p-pri-indfb-multidraw [293.691253] Subtest fbchdr-1p-pri-indfb-multidraw: SKIP (0.000s) [293.792235] [082/156] (745s left) api_intel_allocator (fork-simple-stress) [293.844970] Starting subtest: fork-simple-stress [299.297571] Subtest fork-simple-stress: SUCCESS (5.399s) [299.376575] [083/156] (739s left) syncobj_basic (bad-destroy) [299.436702] Starting subtest: bad-destroy [299.439070] Subtest bad-destroy: SUCCESS (0.000s) [299.559739] [084/156] (739s left) gem_exec_reloc (basic-cpu-read-noreloc) [299.628856] Subtest basic-cpu-read-noreloc: SKIP (0.000s) [299.710555] [085/156] (739s left) kms_plane (pixel-format-y-tiled-modifier-source-clamping) [299.805066] Starting subtest: pixel-format-y-tiled-modifier-source-clamping [299.809442] Subtest pixel-format-y-tiled-modifier-source-clamping: SKIP (0.000s) [299.881638] [086/156] (739s left) perf_pmu (busy-accuracy-98) [299.923209] Starting subtest: busy-accuracy-98 [299.925342] Starting dynamic subtest: rcs0 [302.953935] Dynamic subtest rcs0: SUCCESS (3.028s) [302.966327] Starting dynamic subtest: bcs0 [306.056896] Dynamic subtest bcs0: SUCCESS (3.050s) [306.066859] Starting dynamic subtest: vcs0 [309.095110] Dynamic subtest vcs0: SUCCESS (3.039s) [309.107315] Starting dynamic subtest: vcs1 [312.090162] Dynamic subtest vcs1: SUCCESS (3.040s) [312.100130] Starting dynamic subtest: vecs0 [315.180300] Dynamic subtest vecs0: SUCCESS (3.038s) [315.191974] Starting dynamic subtest: ccs0 [318.232091] Dynamic subtest ccs0: SUCCESS (3.050s) [318.234320] Subtest busy-accuracy-98: SUCCESS (18.259s) [318.300954] [087/156] (720s left) kms_plane_scaling (planes-downscale-factor-0-5) [318.390899] Starting subtest: planes-downscale-factor-0-5 [318.393198] Starting dynamic subtest: pipe-A [318.413938] Dynamic subtest pipe-A: SKIP (0.019s) [318.425266] Starting dynamic subtest: pipe-B [318.446078] Dynamic subtest pipe-B: SKIP (0.033s) [318.455777] Starting dynamic subtest: pipe-C [318.479500] Dynamic subtest pipe-C: SKIP (0.032s) [318.489062] Starting dynamic subtest: pipe-D [318.512920] Dynamic subtest pipe-D: SKIP (0.033s) [318.516794] Subtest planes-downscale-factor-0-5: SKIP (0.120s) [318.632395] [088/156] (720s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [318.726998] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-gtt [318.731125] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [318.827065] [089/156] (720s left) vgem_basic (busy-fence) [318.877716] Starting subtest: busy-fence [318.879726] Subtest busy-fence: SUCCESS (0.000s) [318.936781] [090/156] (720s left) gem_lmem_swapping (verify-random) [318.988893] Subtest verify-random: SKIP (0.000s) [319.033748] [091/156] (720s left) prime_vgem (basic-gtt) [319.120482] Starting subtest: basic-gtt [319.125086] Subtest basic-gtt: SKIP (0.000s) [319.216252] [092/156] (720s left) gem_wait (write-busy) [319.286924] Starting subtest: write-busy [319.289075] Starting dynamic subtest: all-engines [319.899744] Dynamic subtest all-engines: SUCCESS (0.612s) [319.917384] Starting dynamic subtest: rcs0 [320.450059] Dynamic subtest rcs0: SUCCESS (0.548s) [320.465939] Starting dynamic subtest: bcs0 [320.998186] Dynamic subtest bcs0: SUCCESS (0.547s) [321.014770] Starting dynamic subtest: vcs0 [322.302397] Dynamic subtest vcs0: SUCCESS (1.302s) [322.318673] Starting dynamic subtest: vcs1 [324.286853] Dynamic subtest vcs1: SUCCESS (1.981s) [324.304579] Starting dynamic subtest: vecs0 [326.270821] Dynamic subtest vecs0: SUCCESS (1.980s) [326.288357] Starting dynamic subtest: ccs0 [326.823147] Dynamic subtest ccs0: SUCCESS (0.551s) [326.825681] Subtest write-busy: SUCCESS (7.536s) [327.021563] [093/156] (712s left) gem_mmap_offset (clear) [327.072879] Starting subtest: clear [327.074759] Starting dynamic subtest: smem0 [352.012868] Dynamic subtest smem0: SUCCESS (24.933s) [352.015417] Subtest clear: SUCCESS (24.935s) [352.173598] [094/156] (687s left) gem_exec_params (secure-non-master) [352.301310] Starting subtest: secure-non-master [352.305475] Subtest secure-non-master: SKIP (0.000s) [352.409059] [095/156] (687s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt) [352.527558] Starting subtest: fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt [352.531985] Subtest fbcpsrhdr-2p-primscrn-cur-indfb-draw-blt: SKIP (0.000s) [352.632268] [096/156] (686s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [352.736087] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [352.738304] Starting dynamic subtest: pipe-A-eDP-1 [352.796214] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [352.808804] Starting dynamic subtest: pipe-B-eDP-1 [352.867090] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [352.878317] Starting dynamic subtest: pipe-C-eDP-1 [352.935778] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [352.946553] Starting dynamic subtest: pipe-D-eDP-1 [352.999560] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [353.003332] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s) [355.033612] [097/156] (684s left) syncobj_timeline (etime-multi-wait-all-for-submit-unsubmitted-signaled) [355.096710] Starting subtest: etime-multi-wait-all-for-submit-unsubmitted-signaled [355.204781] Subtest etime-multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.105s) [355.283532] [098/156] (684s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [355.392065] Starting subtest: psr-modesetfrombusy [361.598790] Subtest psr-modesetfrombusy: SUCCESS (6.213s) [361.755258] [099/156] (677s left) kms_frontbuffer_tracking (fbchdr-rgb101010-draw-mmap-cpu) [361.861934] Starting subtest: fbchdr-rgb101010-draw-mmap-cpu [361.865547] Subtest fbchdr-rgb101010-draw-mmap-cpu: SKIP (0.000s) [361.967946] [100/156] (677s left) kms_cursor_crc (cursor-onscreen-256x256) [362.218298] Starting subtest: cursor-onscreen-256x256 [362.220234] Starting dynamic subtest: pipe-A-eDP-1 [364.361252] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.139s) [364.392387] Starting dynamic subtest: pipe-D-eDP-1 [367.164083] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.781s) [367.166810] Subtest cursor-onscreen-256x256: SUCCESS (4.947s) [368.071161] [101/156] (671s left) syncobj_wait (invalid-wait-illegal-handle) [368.129156] Starting subtest: invalid-wait-illegal-handle [368.131548] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s) [368.221056] [102/156] (671s left) kms_chamelium_color (gamma) [368.312884] Subtest gamma: SKIP (0.000s) [368.358681] [103/156] (671s left) syncobj_timeline (invalid-query-illegal-handle) [368.420607] Starting subtest: invalid-query-illegal-handle [368.422753] Subtest invalid-query-illegal-handle: SUCCESS (0.000s) [368.521743] [104/156] (671s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [368.621075] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [368.625524] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [368.710846] [105/156] (671s left) gem_render_copy_redux (flink-interruptible) [368.774571] Starting subtest: flink-interruptible [369.520513] Subtest flink-interruptible: SUCCESS (0.746s) [369.646629] [106/156] (670s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip) [369.743988] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip [370.379714] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.637s) [370.567676] [107/156] (669s left) gem_ctx_persistence (hang) [370.617552] Starting subtest: hang [370.622401] Subtest hang: SKIP (0.000s) [370.700741] [108/156] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-move) [370.808249] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-move [370.812310] Subtest fbcpsr-2p-scndscrn-spr-indfb-move: SKIP (0.000s) [370.900822] [109/156] (669s left) i915_pm_freq_mult (media-freq) [370.952814] Starting subtest: media-freq [370.955069] Starting dynamic subtest: gt0 [370.959199] Dynamic subtest gt0: SKIP (0.000s) [370.969178] Starting dynamic subtest: gt1 [370.973115] Dynamic subtest gt1: SKIP (0.000s) [370.977036] Subtest media-freq: SKIP (0.002s) [371.047445] [110/156] (669s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-indfb-draw-mmap-cpu) [371.141870] Starting subtest: fbc-1p-primscrn-pri-indfb-draw-mmap-cpu [375.507904] Subtest fbc-1p-primscrn-pri-indfb-draw-mmap-cpu: SUCCESS (4.371s) [376.658719] [111/156] (663s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0) [376.756470] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0 [376.760756] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0: SKIP (0.000s) [376.851246] [112/156] (663s left) gem_exec_fence (syncobj-timeline-signal) [377.417766] Starting subtest: syncobj-timeline-signal [377.423972] Subtest syncobj-timeline-signal: SUCCESS (0.008s) [378.415739] [113/156] (661s left) gem_lmem_swapping (parallel-random-verify) [378.458588] Subtest parallel-random-verify: SKIP (0.000s) [378.509981] [114/156] (661s left) prime_vgem (basic-fence-read) [378.578796] Starting subtest: basic-fence-read [378.588158] Subtest basic-fence-read: SKIP (0.007s) [378.692592] [115/156] (661s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render) [378.784434] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render [378.788669] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s) [378.888389] [116/156] (661s left) kms_psr (psr2-primary-blt) [378.977865] Starting subtest: psr2-primary-blt [378.980086] Starting dynamic subtest: eDP-1 [380.733237] Dynamic subtest eDP-1: SUCCESS (1.753s) [380.735577] Subtest psr2-primary-blt: SUCCESS (1.754s) [381.612151] [117/156] (658s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc) [381.721162] Starting subtest: fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc [389.952215] Subtest fbcpsr-1p-primscrn-pri-shrfb-draw-mmap-wc: SUCCESS (8.238s) [390.090247] [118/156] (650s left) kms_flip (plain-flip-fb-recreate-interruptible) [390.191772] Starting subtest: plain-flip-fb-recreate-interruptible [390.193961] Starting dynamic subtest: A-eDP1 [399.052453] Dynamic subtest A-eDP1: SUCCESS (8.859s) [399.065167] Starting dynamic subtest: B-eDP1 [407.877965] Dynamic subtest B-eDP1: SUCCESS (8.823s) [407.888626] Starting dynamic subtest: C-eDP1 [416.707112] Dynamic subtest C-eDP1: SUCCESS (8.828s) [416.719475] Starting dynamic subtest: D-eDP1 [425.536565] Dynamic subtest D-eDP1: SUCCESS (8.828s) [425.540891] Subtest plain-flip-fb-recreate-interruptible: SUCCESS (35.349s) [426.726230] [119/156] (613s left) core_auth (basic-auth) [426.773050] Starting subtest: basic-auth [426.775375] Subtest basic-auth: SUCCESS (0.001s) [426.874017] [120/156] (613s left) kms_properties (colorop-properties-atomic) [426.966711] Starting subtest: colorop-properties-atomic [426.968853] Starting dynamic subtest: pipe-A-eDP-1 [427.358940] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.392s) [427.373052] Starting dynamic subtest: pipe-B-eDP-1 [428.408654] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.047s) [428.419632] Starting dynamic subtest: pipe-C-eDP-1 [429.541410] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.131s) [429.553371] Starting dynamic subtest: pipe-D-eDP-1 [430.573214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.032s) [430.575578] Subtest colorop-properties-atomic: SUCCESS (3.608s) [431.482502] [121/156] (609s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render) [431.588396] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render [438.739426] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (7.155s) [438.860114] [122/156] (601s left) kms_addfb_basic (basic-x-tiled-legacy) [438.932627] Starting subtest: basic-x-tiled-legacy [438.937216] Subtest basic-x-tiled-legacy: SKIP (0.000s) [439.067094] [123/156] (601s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-render) [439.176697] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-render [439.181128] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [439.268663] [124/156] (601s left) kms_frontbuffer_tracking (psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu) [439.373172] Starting subtest: psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu [439.377162] Subtest psrhdr-2p-primscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [439.476983] [125/156] (601s left) syncobj_timeline (wait-for-submit-complex) [439.530541] Starting subtest: wait-for-submit-complex [439.591273] Subtest wait-for-submit-complex: SUCCESS (0.062s) [439.668951] [126/156] (601s left) kms_psr (fbc-psr-no-drrs) [439.760675] Starting subtest: fbc-psr-no-drrs [439.762632] Starting dynamic subtest: eDP-1 [439.766142] Dynamic subtest eDP-1: SKIP (0.000s) [439.769701] Subtest fbc-psr-no-drrs: SKIP (0.001s) [439.833205] [127/156] (600s left) kms_frontbuffer_tracking (hdr-2p-primscrn-pri-shrfb-draw-blt) [439.932388] Starting subtest: hdr-2p-primscrn-pri-shrfb-draw-blt [439.935819] Subtest hdr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [440.034343] [128/156] (600s left) kms_color (ctm-blue-to-red) [440.122932] Starting subtest: ctm-blue-to-red [440.124580] Starting dynamic subtest: pipe-A-eDP-1 [440.862317] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.739s) [440.873310] Starting dynamic subtest: pipe-B-eDP-1 [442.252800] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.389s) [442.265112] Starting dynamic subtest: pipe-C-eDP-1 [443.620862] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.367s) [443.631408] Starting dynamic subtest: pipe-D-eDP-1 [444.952621] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.333s) [444.955071] Subtest ctm-blue-to-red: SUCCESS (4.831s) [445.768784] [129/156] (595s left) i915_drm_fdinfo (memory-info-resident) [445.808445] Starting subtest: memory-info-resident [445.810612] Starting dynamic subtest: smem0 [448.289545] Dynamic subtest smem0: SUCCESS (2.481s) [448.292331] Subtest memory-info-resident: SUCCESS (2.482s) [448.364784] [130/156] (592s left) kms_frontbuffer_tracking (hdr-rgb565-draw-blt) [448.462405] Starting subtest: hdr-rgb565-draw-blt [448.465938] Subtest hdr-rgb565-draw-blt: SKIP (0.000s) [448.556690] [131/156] (592s left) kms_addfb_basic (addfb25-bad-modifier) [448.658384] Starting subtest: addfb25-bad-modifier [448.660232] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [448.789307] [132/156] (592s left) kms_plane_cursor (viewport) [448.882044] Starting subtest: viewport [448.885644] Starting dynamic subtest: pipe-A-eDP-1-size-64 [451.592185] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.709s) [451.654462] Starting dynamic subtest: pipe-A-eDP-1-size-128 [454.349202] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.704s) [454.410705] Starting dynamic subtest: pipe-A-eDP-1-size-256 [457.073317] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.671s) [457.426683] Starting dynamic subtest: pipe-B-eDP-1-size-64 [460.909033] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.493s) [460.970482] Starting dynamic subtest: pipe-B-eDP-1-size-128 [463.666056] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.705s) [463.727249] Starting dynamic subtest: pipe-B-eDP-1-size-256 [466.399515] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.682s) [466.760626] Starting dynamic subtest: pipe-C-eDP-1-size-64 [469.831588] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (3.083s) [469.870146] Starting dynamic subtest: pipe-C-eDP-1-size-128 [472.254425] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.392s) [472.295255] Starting dynamic subtest: pipe-C-eDP-1-size-256 [474.653582] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.370s) [474.987481] Starting dynamic subtest: pipe-D-eDP-1-size-64 [478.033791] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (3.058s) [478.072827] Starting dynamic subtest: pipe-D-eDP-1-size-128 [480.412148] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.348s) [480.451757] Starting dynamic subtest: pipe-D-eDP-1-size-256 [482.800100] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.358s) [483.117137] Subtest viewport: SUCCESS (34.234s) [484.031016] [133/156] (557s left) kms_flip (dpms-vs-vblank-race-interruptible) [484.131320] Starting subtest: dpms-vs-vblank-race-interruptible [484.133237] Starting dynamic subtest: A-eDP1 [488.068216] Dynamic subtest A-eDP1: SUCCESS (3.933s) [488.080315] Starting dynamic subtest: B-eDP1 [491.648324] Dynamic subtest B-eDP1: SUCCESS (3.577s) [491.659800] Starting dynamic subtest: C-eDP1 [495.225749] Dynamic subtest C-eDP1: SUCCESS (3.575s) [495.239858] Starting dynamic subtest: D-eDP1 [499.880587] Dynamic subtest D-eDP1: SUCCESS (4.654s) [499.883035] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (15.750s) [500.755480] [134/156] (540s left) kms_force_connector_basic (prune-stale-modes) [500.841915] Starting subtest: prune-stale-modes [501.284687] Subtest prune-stale-modes: SUCCESS (0.443s) [501.437390] [135/156] (539s left) kms_psr (psr2-cursor-mmap-cpu) [501.527713] Starting subtest: psr2-cursor-mmap-cpu [501.530131] Starting dynamic subtest: eDP-1 [503.219612] Dynamic subtest eDP-1: SUCCESS (1.693s) [503.221841] Subtest psr2-cursor-mmap-cpu: SUCCESS (1.694s) [504.092085] [136/156] (537s left) gem_create (create-ext-set-pat) [504.263288] Starting subtest: create-ext-set-pat [504.265962] Subtest create-ext-set-pat: SUCCESS (0.001s) [504.371643] [137/156] (536s left) syncobj_timeline (reset-multiple-signaled) [504.420703] Starting subtest: reset-multiple-signaled [504.422717] Subtest reset-multiple-signaled: SUCCESS (0.000s) [504.539886] [138/156] (536s left) kms_properties (crtc-properties-atomic) [504.626049] Starting subtest: crtc-properties-atomic [504.628347] Starting dynamic subtest: pipe-A-eDP-1 [505.062074] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.434s) [505.074046] Starting dynamic subtest: pipe-B-eDP-1 [506.204594] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.142s) [506.215279] Starting dynamic subtest: pipe-C-eDP-1 [507.393893] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.187s) [507.405226] Starting dynamic subtest: pipe-D-eDP-1 [508.608073] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.214s) [508.610506] Subtest crtc-properties-atomic: SUCCESS (3.983s) [509.480171] [139/156] (531s left) gem_caching (read-writes) [509.553130] Subtest read-writes: SKIP (0.000s) [509.639074] [140/156] (531s left) syncobj_timeline (invalid-multi-wait-unsubmitted-submitted-signaled) [509.687046] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled [509.689377] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s) [509.787236] [141/156] (531s left) kms_addfb_basic (bad-pitch-1024) [509.846595] Starting subtest: bad-pitch-1024 [509.848539] Subtest bad-pitch-1024: SUCCESS (0.000s) [510.006625] [142/156] (531s left) kms_frontbuffer_tracking (fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc) [510.111509] Starting subtest: fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc [510.115987] Subtest fbcpsrhdr-2p-primscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s) [510.219909] [143/156] (531s left) syncobj_wait (reset-multiple-signaled) [510.270886] Starting subtest: reset-multiple-signaled [510.273621] Subtest reset-multiple-signaled: SUCCESS (0.000s) [510.370683] [144/156] (531s left) kms_psr (fbc-pr-primary-mmap-gtt) [510.475044] Starting subtest: fbc-pr-primary-mmap-gtt [510.478836] Subtest fbc-pr-primary-mmap-gtt: SKIP (0.000s) [510.546946] [145/156] (531s left) kms_frontbuffer_tracking (psrhdr-2p-scndscrn-shrfb-msflip-blt) [510.643498] Starting subtest: psrhdr-2p-scndscrn-shrfb-msflip-blt [510.646937] Subtest psrhdr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [510.742172] [146/156] (530s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-mmap-gtt) [510.845994] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-mmap-gtt [510.849752] Subtest fbc-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [510.944440] [147/156] (530s left) kms_content_protection (dp-mst-lic-type-0-hdcp14) [511.074668] Starting subtest: dp-mst-lic-type-0-hdcp14 [511.078557] Subtest dp-mst-lic-type-0-hdcp14: SKIP (0.000s) [511.188802] [148/156] (530s left) api_intel_bb (object-reloc-keep-cache) [511.235100] Starting subtest: object-reloc-keep-cache [511.240956] Subtest object-reloc-keep-cache: SKIP (0.004s) [511.357689] [149/156] (530s left) gem_exec_suspend (basic-s3) [511.413237] Starting subtest: basic-S3 [511.415327] Starting dynamic subtest: smem [532.766144] Dynamic subtest smem: SUCCESS (7.871s) [532.769368] Subtest basic-S3: SUCCESS (7.874s) [532.954246] [150/156] (508s left) kms_frontbuffer_tracking (fbchdr-2p-scndscrn-cur-indfb-move) [533.080575] Starting subtest: fbchdr-2p-scndscrn-cur-indfb-move [533.084779] Subtest fbchdr-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [533.196893] [151/156] (508s left) kms_psr (fbc-psr2-cursor-plane-onoff) [533.289142] Starting subtest: fbc-psr2-cursor-plane-onoff [533.291442] Starting dynamic subtest: eDP-1 [533.295897] Dynamic subtest eDP-1: SKIP (0.000s) [533.300319] Subtest fbc-psr2-cursor-plane-onoff: SKIP (0.001s) [533.365160] [152/156] (508s left) kms_addfb_basic (bad-pitch-128) [533.420025] Starting subtest: bad-pitch-128 [533.421895] Subtest bad-pitch-128: SUCCESS (0.000s) [533.556230] [153/156] (508s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [533.654594] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [533.658750] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [533.747630] [154/156] (508s left) kms_ccs (bad-pixel-format-4-tiled-mtl-rc-ccs-cc) [533.840732] Starting subtest: bad-pixel-format-4-tiled-mtl-rc-ccs-cc [533.843080] Starting dynamic subtest: pipe-A-eDP-1 [533.863845] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.000s) [533.877006] Starting dynamic subtest: pipe-B-eDP-1 [533.897195] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s) [533.907447] Starting dynamic subtest: pipe-C-eDP-1 [533.922947] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s) [533.932988] Starting dynamic subtest: pipe-D-eDP-1 [533.949121] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s) [533.950817] Subtest bad-pixel-format-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.005s) [536.058763] [155/156] (505s left) i915_suspend (basic-s2idle-without-i915) [536.100825] Starting subtest: basic-s2idle-without-i915 [557.222677] Subtest basic-s2idle-without-i915: SUCCESS (5.795s) [557.338974] [156/156] (484s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-fully-sf) [557.459583] Starting subtest: pr-cursor-plane-move-continuous-exceed-fully-sf [557.463460] Subtest pr-cursor-plane-move-continuous-exceed-fully-sf: SKIP (0.000s) [557.540729] Closing watchdogs results: parsing output: 0/ for test: kms_vblank results: parsing output: 1/ for test: gem_ppgtt results: parsing output: 2/ for test: kms_cursor_crc results: parsing output: 3/ for test: kms_frontbuffer_tracking results: parsing output: 4/ for test: kms_big_fb results: parsing output: 5/ for test: kms_chamelium_hpd results: parsing output: 6/ for test: kms_flip results: parsing output: 7/ for test: kms_frontbuffer_tracking results: parsing output: 8/ for test: kms_frontbuffer_tracking results: parsing output: 9/ for test: kms_frontbuffer_tracking results: parsing output: 10/ for test: kms_prop_blob results: parsing output: 11/ for test: kms_ccs results: parsing output: 12/ for test: gem_exec_params results: parsing output: 13/ for test: sw_sync results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_big_fb results: parsing output: 16/ for test: gem_softpin results: parsing output: 17/ for test: kms_frontbuffer_tracking results: parsing output: 18/ for test: kms_cursor_legacy results: parsing output: 19/ for test: kms_lease results: parsing output: 20/ for test: kms_lease results: parsing output: 21/ for test: kms_frontbuffer_tracking results: parsing output: 22/ for test: kms_busy results: parsing output: 23/ for test: prime_vgem results: parsing output: 24/ for test: gem_userptr_blits results: parsing output: 25/ for test: gem_spin_batch results: parsing output: 26/ for test: kms_big_fb results: parsing output: 27/ for test: kms_cursor_legacy results: parsing output: 28/ for test: gem_exec_fence results: parsing output: 29/ for test: perf_pmu results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_getfb results: parsing output: 32/ for test: kms_cursor_legacy results: parsing output: 33/ for test: syncobj_wait results: parsing output: 34/ for test: kms_async_flips results: parsing output: 35/ for test: gem_exec_schedule results: parsing output: 36/ for test: kms_draw_crc results: parsing output: 37/ for test: sriov_basic results: parsing output: 38/ for test: gen9_exec_parse results: parsing output: 39/ for test: kms_frontbuffer_tracking results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: kms_plane results: parsing output: 42/ for test: kms_pm_dc results: parsing output: 43/ for test: gem_exec_schedule results: parsing output: 44/ for test: kms_flip results: parsing output: 45/ for test: perf_pmu results: parsing output: 46/ for test: kms_frontbuffer_tracking results: parsing output: 47/ for test: kms_frontbuffer_tracking results: parsing output: 48/ for test: vgem_slow results: parsing output: 49/ for test: kms_ccs results: parsing output: 50/ for test: gem_ctx_shared results: parsing output: 51/ for test: kms_frontbuffer_tracking results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: gem_pxp results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: gem_render_copy results: parsing output: 56/ for test: kms_frontbuffer_tracking results: parsing output: 57/ for test: kms_big_fb results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: gem_exec_balancer results: parsing output: 60/ for test: gem_exec_balancer results: parsing output: 61/ for test: kms_selftest results: parsing output: 62/ for test: kms_frontbuffer_tracking results: parsing output: 63/ for test: kms_cursor_crc results: parsing output: 64/ for test: gem_render_copy results: parsing output: 65/ for test: gem_ctx_param results: parsing output: 66/ for test: kms_plane_scaling results: parsing output: 67/ for test: kms_frontbuffer_tracking results: parsing output: 68/ for test: gem_ctx_persistence results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: i915_query results: parsing output: 71/ for test: kms_psr results: parsing output: 72/ for test: kms_chamelium_audio results: parsing output: 73/ for test: gem_bad_reloc results: parsing output: 74/ for test: kms_flip_scaled_crc results: parsing output: 75/ for test: kms_flip_scaled_crc results: parsing output: 76/ for test: kms_frontbuffer_tracking results: parsing output: 77/ for test: core_setmaster results: parsing output: 78/ for test: kms_rmfb results: parsing output: 79/ for test: i915_pm_rps results: parsing output: 80/ for test: kms_frontbuffer_tracking results: parsing output: 81/ for test: api_intel_allocator results: parsing output: 82/ for test: syncobj_basic results: parsing output: 83/ for test: gem_exec_reloc results: parsing output: 84/ for test: kms_plane results: parsing output: 85/ for test: perf_pmu results: parsing output: 86/ for test: kms_plane_scaling results: parsing output: 87/ for test: kms_frontbuffer_tracking results: parsing output: 88/ for test: vgem_basic results: parsing output: 89/ for test: gem_lmem_swapping results: parsing output: 90/ for test: prime_vgem results: parsing output: 91/ for test: gem_wait results: parsing output: 92/ for test: gem_mmap_offset results: parsing output: 93/ for test: gem_exec_params results: parsing output: 94/ for test: kms_frontbuffer_tracking results: parsing output: 95/ for test: kms_ccs results: parsing output: 96/ for test: syncobj_timeline results: parsing output: 97/ for test: kms_frontbuffer_tracking 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_wait results: parsing output: 101/ for test: kms_chamelium_color results: parsing output: 102/ for test: syncobj_timeline results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_render_copy_redux results: parsing output: 105/ for test: kms_big_fb results: parsing output: 106/ for test: gem_ctx_persistence results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: i915_pm_freq_mult results: parsing output: 109/ for test: kms_frontbuffer_tracking results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: gem_exec_fence results: parsing output: 112/ for test: gem_lmem_swapping results: parsing output: 113/ for test: prime_vgem results: parsing output: 114/ for test: kms_frontbuffer_tracking results: parsing output: 115/ for test: kms_psr results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_flip results: parsing output: 118/ for test: core_auth results: parsing output: 119/ for test: kms_properties results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: kms_addfb_basic results: parsing output: 122/ for test: kms_frontbuffer_tracking results: parsing output: 123/ for test: kms_frontbuffer_tracking results: parsing output: 124/ for test: syncobj_timeline results: parsing output: 125/ for test: kms_psr results: parsing output: 126/ for test: kms_frontbuffer_tracking results: parsing output: 127/ for test: kms_color results: parsing output: 128/ for test: i915_drm_fdinfo results: parsing output: 129/ for test: kms_frontbuffer_tracking results: parsing output: 130/ for test: kms_addfb_basic results: parsing output: 131/ for test: kms_plane_cursor results: parsing output: 132/ for test: kms_flip results: parsing output: 133/ for test: kms_force_connector_basic results: parsing output: 134/ for test: kms_psr results: parsing output: 135/ for test: gem_create results: parsing output: 136/ for test: syncobj_timeline results: parsing output: 137/ for test: kms_properties results: parsing output: 138/ for test: gem_caching results: parsing output: 139/ for test: syncobj_timeline results: parsing output: 140/ for test: kms_addfb_basic results: parsing output: 141/ for test: kms_frontbuffer_tracking results: parsing output: 142/ for test: syncobj_wait results: parsing output: 143/ for test: kms_psr results: parsing output: 144/ for test: kms_frontbuffer_tracking results: parsing output: 145/ for test: kms_frontbuffer_tracking results: parsing output: 146/ for test: kms_content_protection results: parsing output: 147/ for test: api_intel_bb results: parsing output: 148/ for test: gem_exec_suspend results: parsing output: 149/ for test: kms_frontbuffer_tracking results: parsing output: 150/ for test: kms_psr results: parsing output: 151/ for test: kms_addfb_basic results: parsing output: 152/ for test: kms_frontbuffer_tracking results: parsing output: 153/ for test: kms_ccs results: parsing output: 154/ for test: i915_suspend results: parsing output: 155/ for test: kms_psr2_sf Done.