[59.777450] Initializing watchdogs [59.777499] /dev/watchdog0 [59.792974] [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] [59.797796] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [59.800378] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [59.803941] [001/132] (960s left) gem_exec_reloc (basic-write-read-noreloc) [59.897748] Subtest basic-write-read-noreloc: SKIP (0.000s) [59.977449] [002/132] (960s left) gem_exec_params (no-blt) [60.039875] Starting subtest: no-blt [60.045054] Subtest no-blt: SUCCESS (0.003s) [60.169902] [003/132] (960s left) kms_addfb_basic (unused-offsets) [60.231498] Starting subtest: unused-offsets [60.233767] Subtest unused-offsets: SUCCESS (0.000s) [60.368078] [004/132] (960s left) gem_exec_schedule (fifo) [60.440591] Starting subtest: fifo [60.442922] Starting dynamic subtest: rcs0 [60.530473] Dynamic subtest rcs0: SUCCESS (0.098s) [60.541537] Starting dynamic subtest: vcs0 [60.611949] Dynamic subtest vcs0: SUCCESS (0.081s) [60.625275] Starting dynamic subtest: vcs1 [60.692047] Dynamic subtest vcs1: SUCCESS (0.079s) [60.700905] Starting dynamic subtest: vecs0 [60.771258] Dynamic subtest vecs0: SUCCESS (0.078s) [60.781276] Starting dynamic subtest: ccs0 [60.851883] Dynamic subtest ccs0: SUCCESS (0.079s) [60.854466] Subtest fifo: SUCCESS (0.418s) [62.360726] [005/132] (958s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-blt) [62.452056] Starting subtest: fbcpsr-rgb101010-draw-blt [69.233513] Subtest fbcpsr-rgb101010-draw-blt: SUCCESS (6.748s) [69.337376] [006/132] (951s left) kms_pipe_stress (stress-xrgb8888-yftiled) [69.429650] Starting subtest: stress-xrgb8888-yftiled [69.434332] Subtest stress-xrgb8888-yftiled: SKIP (0.000s) [69.518528] [007/132] (951s left) gem_exec_schedule (submit-late-slice) [69.586123] Starting subtest: submit-late-slice [69.588234] Starting dynamic subtest: rcs0 [69.614504] Dynamic subtest rcs0: SUCCESS (0.037s) [69.622338] Starting dynamic subtest: bcs0 [69.644199] Dynamic subtest bcs0: SUCCESS (0.029s) [69.654733] Starting dynamic subtest: vcs0 [69.673596] Dynamic subtest vcs0: SUCCESS (0.029s) [69.681563] Starting dynamic subtest: vcs1 [69.703412] Dynamic subtest vcs1: SUCCESS (0.029s) [69.715794] Starting dynamic subtest: vecs0 [69.732798] Dynamic subtest vecs0: SUCCESS (0.029s) [69.741048] Starting dynamic subtest: ccs0 [69.761530] Dynamic subtest ccs0: SUCCESS (0.028s) [69.763881] Subtest submit-late-slice: SUCCESS (0.183s) [71.377930] [008/132] (949s left) gem_exec_suspend (basic-s3) [71.439734] Starting subtest: basic-S3 [71.442206] Starting dynamic subtest: smem [92.541756] Dynamic subtest smem: SUCCESS (6.843s) [92.544531] Subtest basic-S3: SUCCESS (6.845s) [92.730243] [009/132] (927s left) kms_cursor_legacy (cursor-vs-flip-atomic) [92.870795] Starting subtest: cursor-vs-flip-atomic [122.877614] Subtest cursor-vs-flip-atomic: SUCCESS (29.827s) [123.702859] [010/132] (896s left) gem_exec_async (forked-writes) [123.770328] Starting subtest: forked-writes [123.772892] Starting dynamic subtest: rcs0 [123.799085] Dynamic subtest rcs0: SUCCESS (0.028s) [123.811291] Starting dynamic subtest: bcs0 [123.822246] Dynamic subtest bcs0: SUCCESS (0.023s) [123.832931] Starting dynamic subtest: vcs0 [123.845245] Dynamic subtest vcs0: SUCCESS (0.023s) [123.855054] Starting dynamic subtest: vcs1 [123.867318] Dynamic subtest vcs1: SUCCESS (0.022s) [123.876508] Starting dynamic subtest: vecs0 [123.892600] Dynamic subtest vecs0: SUCCESS (0.025s) [123.901861] Starting dynamic subtest: ccs0 [123.915740] Dynamic subtest ccs0: SUCCESS (0.023s) [123.918103] Subtest forked-writes: SUCCESS (0.146s) [124.154228] [011/132] (896s left) kms_big_fb (x-tiled-16bpp-rotate-180) [124.268753] Starting subtest: x-tiled-16bpp-rotate-180 [125.614863] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.346s) [125.720184] [012/132] (895s left) kms_properties (get_properties-sanity-non-atomic) [125.808857] Starting subtest: get_properties-sanity-non-atomic [125.810838] Subtest get_properties-sanity-non-atomic: SUCCESS (0.002s) [125.880570] [013/132] (894s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip) [125.974445] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip [125.977837] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [126.071124] [014/132] (894s left) kms_psr (fbc-psr-suspend) [126.162045] Starting subtest: fbc-psr-suspend [126.164126] Starting dynamic subtest: eDP-1 [126.167806] Dynamic subtest eDP-1: SKIP (0.000s) [126.171339] Subtest fbc-psr-suspend: SKIP (0.001s) [126.232243] [015/132] (894s left) i915_drm_fdinfo (most-busy-idle-check-all) [126.272022] Starting subtest: most-busy-idle-check-all [126.274030] Starting dynamic subtest: rcs0 [126.277651] Dynamic subtest rcs0: SKIP (0.003s) [126.286389] Starting dynamic subtest: bcs0 [126.289857] Dynamic subtest bcs0: SKIP (0.000s) [126.297967] Starting dynamic subtest: vcs0 [126.301635] Dynamic subtest vcs0: SKIP (0.000s) [126.309480] Starting dynamic subtest: vcs1 [126.313146] Dynamic subtest vcs1: SKIP (0.000s) [126.321120] Starting dynamic subtest: vecs0 [126.324830] Dynamic subtest vecs0: SKIP (0.000s) [126.332682] Starting dynamic subtest: ccs0 [126.336190] Dynamic subtest ccs0: SKIP (0.000s) [126.339954] Subtest most-busy-idle-check-all: SKIP (0.006s) [126.376127] [016/132] (894s left) gem_mmap_gtt (zero-extend) [126.451447] Subtest zero-extend: SKIP (0.000s) [126.513306] [017/132] (894s left) syncobj_timeline (invalid-signal-illegal-handle) [126.565303] Starting subtest: invalid-signal-illegal-handle [126.567260] Subtest invalid-signal-illegal-handle: SUCCESS (0.000s) [126.649072] [018/132] (894s left) gem_mmap_gtt (basic-small-bo) [126.704757] Subtest basic-small-bo: SKIP (0.000s) [126.764630] [019/132] (894s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-downscaling) [126.856742] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-downscaling [126.860203] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-downscaling: SKIP (0.000s) [126.924905] [020/132] (894s left) gem_pxp (protected-raw-src-copy-not-readible) [127.046016] Starting subtest: protected-raw-src-copy-not-readible [127.107095] Subtest protected-raw-src-copy-not-readible: SUCCESS (0.063s) [127.238865] [021/132] (893s left) syncobj_wait (invalid-multi-wait-all-unsubmitted-signaled) [127.287355] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [127.289369] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.000s) [127.373034] [022/132] (893s left) gem_exec_balancer (parallel) [127.632654] Starting subtest: parallel [128.587808] Subtest parallel: SUCCESS (0.954s) [129.547078] [023/132] (891s left) gem_softpin (allocator-nopin-reserve) [129.612166] Starting subtest: allocator-nopin-reserve [129.721842] Subtest allocator-nopin-reserve: SUCCESS (0.108s) [129.877055] [024/132] (891s left) syncobj_eventfd (invalid-illegal-handle) [129.953344] Starting subtest: invalid-illegal-handle [129.955834] Subtest invalid-illegal-handle: SUCCESS (0.000s) [130.058411] [025/132] (891s left) gem_exec_reloc (basic-gtt-read-noreloc) [130.133587] Subtest basic-gtt-read-noreloc: SKIP (0.000s) [130.205329] [026/132] (891s left) kms_plane (pixel-format-y-tiled-ccs-modifier-source-clamping) [130.306206] Starting subtest: pixel-format-y-tiled-ccs-modifier-source-clamping [130.310356] Subtest pixel-format-y-tiled-ccs-modifier-source-clamping: SKIP (0.000s) [130.374420] [027/132] (890s left) kms_addfb_basic (addfb25-bad-modifier) [130.477661] Starting subtest: addfb25-bad-modifier [130.479989] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [130.577958] [028/132] (890s left) gem_userptr_blits (invalid-mmap-offset-unsync) [130.656865] Subtest invalid-mmap-offset-unsync: SKIP (0.000s) [130.784883] [029/132] (890s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-pwrite) [130.883735] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-pwrite [138.065205] Subtest fbc-1p-offscreen-pri-shrfb-draw-pwrite: SUCCESS (7.179s) [139.214904] [030/132] (882s left) gem_exec_params (invalid-bsd2-flag-on-vebox) [139.274556] Starting subtest: invalid-bsd2-flag-on-vebox [139.277043] Subtest invalid-bsd2-flag-on-vebox: SUCCESS (0.000s) [139.381061] [031/132] (882s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-move) [139.471562] Starting subtest: fbc-1p-primscrn-spr-indfb-move [143.766649] Subtest fbc-1p-primscrn-spr-indfb-move: SUCCESS (4.297s) [144.935650] [032/132] (876s left) kms_pm_backlight (fade) [145.032917] Starting subtest: fade [145.081337] Starting dynamic subtest: eDP-1 [147.771487] Dynamic subtest eDP-1: SUCCESS (2.687s) [147.773991] Subtest fade: SUCCESS (2.739s) [148.659342] [033/132] (872s left) kms_chamelium_color (ctm-red-to-blue) [148.749582] Subtest ctm-red-to-blue: SKIP (0.000s) [148.792780] [034/132] (872s left) gem_render_copy (y-tiled-to-vebox-linear) [148.853990] Starting subtest: y-tiled-to-vebox-linear [148.858435] Subtest y-tiled-to-vebox-linear: SKIP (0.000s) [149.030592] [035/132] (872s left) gem_sync (basic-all) [149.104868] Starting subtest: basic-all [152.448614] Subtest basic-all: SUCCESS (3.351s) [152.628636] [036/132] (869s left) kms_cursor_crc (cursor-offscreen-512x512) [152.901311] Starting subtest: cursor-offscreen-512x512 [152.905905] Subtest cursor-offscreen-512x512: SKIP (0.001s) [153.067305] [037/132] (868s left) gem_mmap_wc (write-read) [153.123736] Subtest write-read: SKIP (0.000s) [153.188271] [038/132] (868s left) core_getversion (all-cards) [153.230043] Starting subtest: all-cards [153.236953] Subtest all-cards: SUCCESS (0.009s) [153.274518] [039/132] (868s left) gem_create (create-ext-cpu-access-big) [153.440005] Starting subtest: create-ext-cpu-access-big [153.444925] Subtest create-ext-cpu-access-big: SKIP (0.001s) [153.515387] [040/132] (868s left) kms_invalid_mode (clock-too-high) [153.603696] Starting subtest: clock-too-high [153.605580] Starting dynamic subtest: pipe-A-eDP-1 [153.609627] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [153.622613] Starting dynamic subtest: pipe-B-eDP-1 [153.627071] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [153.638470] Starting dynamic subtest: pipe-C-eDP-1 [153.642924] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [153.651187] Starting dynamic subtest: pipe-D-eDP-1 [153.655365] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [153.659444] Subtest clock-too-high: SKIP (0.003s) [153.694523] [041/132] (868s left) gem_exec_capture (capture-recoverable) [153.762847] Starting subtest: capture-recoverable [153.765274] Subtest capture-recoverable: SUCCESS (0.003s) [153.880203] [042/132] (868s left) kms_plane (pixel-format-4-tiled-bmg-ccs-modifier-source-clamping) [153.981529] Starting subtest: pixel-format-4-tiled-bmg-ccs-modifier-source-clamping [153.985893] Subtest pixel-format-4-tiled-bmg-ccs-modifier-source-clamping: SKIP (0.000s) [154.053008] [043/132] (867s left) kms_addfb_basic (bad-pitch-1024) [154.112357] Starting subtest: bad-pitch-1024 [154.114690] Subtest bad-pitch-1024: SUCCESS (0.000s) [154.241342] [044/132] (867s left) kms_getfb (getfb-reject-nv12) [154.339640] Starting subtest: getfb-reject-nv12 [154.341609] Subtest getfb-reject-nv12: SUCCESS (0.001s) [154.454531] [045/132] (867s left) gem_ctx_persistence (legacy-engines-mixed-process) [154.523134] Starting subtest: legacy-engines-mixed-process [154.525156] Starting dynamic subtest: render [156.500094] Dynamic subtest render: SUCCESS (1.975s) [156.510815] Starting dynamic subtest: bsd1 [158.537431] Dynamic subtest bsd1: SUCCESS (2.035s) [158.548683] Starting dynamic subtest: bsd2 [160.515249] Dynamic subtest bsd2: SUCCESS (1.975s) [160.527382] Starting dynamic subtest: blt [162.477748] Dynamic subtest blt: SUCCESS (1.959s) [162.489008] Starting dynamic subtest: vebox [164.469316] Dynamic subtest vebox: SUCCESS (1.990s) [164.471780] Subtest legacy-engines-mixed-process: SUCCESS (9.941s) [164.551828] [046/132] (857s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [164.651299] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [164.653283] Starting dynamic subtest: pipe-A-eDP-1 [165.077337] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s) [165.088962] Starting dynamic subtest: pipe-B-eDP-1 [165.109129] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [165.119201] Starting dynamic subtest: pipe-C-eDP-1 [165.137967] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s) [165.146752] Starting dynamic subtest: pipe-D-eDP-1 [165.165995] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [165.167878] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.441s) [167.336317] [047/132] (854s left) kms_cursor_legacy (forked-bo) [167.459710] Starting subtest: forked-bo [167.462040] Starting dynamic subtest: pipe-A [172.925632] Dynamic subtest pipe-A: SUCCESS (5.459s) [172.936713] Starting dynamic subtest: pipe-B [178.404440] Dynamic subtest pipe-B: SUCCESS (5.475s) [178.416293] Starting dynamic subtest: pipe-C [183.878062] Dynamic subtest pipe-C: SUCCESS (5.471s) [183.891590] Starting dynamic subtest: pipe-D [189.351907] Dynamic subtest pipe-D: SUCCESS (5.473s) [189.364433] Starting dynamic subtest: all-pipes [194.861019] Dynamic subtest all-pipes: SUCCESS (5.508s) [194.863371] Subtest forked-bo: SUCCESS (27.390s) [195.003330] [048/132] (827s left) gem_request_retire (retire-vma-not-inactive) [195.076180] Starting subtest: retire-vma-not-inactive [195.135489] Subtest retire-vma-not-inactive: SUCCESS (0.059s) [195.244979] [049/132] (827s left) kms_content_protection (dp-mst-type-0-suspend-resume) [195.387197] Starting subtest: dp-mst-type-0-suspend-resume [195.391706] Subtest dp-mst-type-0-suspend-resume: SKIP (0.000s) [195.496998] [050/132] (826s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible) [195.603003] Starting subtest: flip-vs-absolute-wf_vblank-interruptible [195.606019] Starting dynamic subtest: A-eDP1 [204.486575] Dynamic subtest A-eDP1: SUCCESS (8.883s) [204.498296] Starting dynamic subtest: B-eDP1 [213.418489] Dynamic subtest B-eDP1: SUCCESS (8.932s) [213.430445] Starting dynamic subtest: C-eDP1 [222.333638] Dynamic subtest C-eDP1: SUCCESS (8.912s) [222.344821] Starting dynamic subtest: D-eDP1 [231.268067] Dynamic subtest D-eDP1: SUCCESS (8.931s) [231.273153] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.673s) [232.498019] [051/132] (789s left) api_intel_bb (offset-control) [232.552289] Starting subtest: offset-control [232.564424] Subtest offset-control: SUCCESS (0.014s) [232.719077] [052/132] (789s left) kms_big_fb (y-tiled-32bpp-rotate-0) [232.827368] Starting subtest: y-tiled-32bpp-rotate-0 [232.831765] Subtest y-tiled-32bpp-rotate-0: SKIP (0.000s) [232.910904] [053/132] (789s left) kms_psr (fbc-psr2-cursor-plane-move) [232.998609] Starting subtest: fbc-psr2-cursor-plane-move [233.000529] Starting dynamic subtest: eDP-1 [233.004630] Dynamic subtest eDP-1: SKIP (0.000s) [233.008727] Subtest fbc-psr2-cursor-plane-move: SKIP (0.001s) [233.081023] [054/132] (789s left) gem_ctx_isolation (preservation-s3) [233.151110] Starting subtest: preservation-S3 [233.153535] Starting dynamic subtest: rcs0 [248.639693] Dynamic subtest rcs0: SUCCESS (1.310s) [248.650474] Starting dynamic subtest: bcs0 [264.638056] Dynamic subtest bcs0: SUCCESS (1.324s) [264.650307] Starting dynamic subtest: vcs0 [280.659682] Dynamic subtest vcs0: SUCCESS (2.738s) [280.670235] Starting dynamic subtest: vcs1 [298.644301] Dynamic subtest vcs1: SUCCESS (4.876s) [298.654600] Starting dynamic subtest: vecs0 [316.641950] Dynamic subtest vecs0: SUCCESS (4.887s) [316.653004] Starting dynamic subtest: ccs0 [334.651276] Dynamic subtest ccs0: SUCCESS (3.132s) [334.653561] Subtest preservation-S3: SUCCESS (18.271s) [334.878855] [055/132] (687s left) gem_partial_pwrite_pread (write-snoop) [334.955285] Subtest write-snoop: SKIP (0.000s) [335.023375] [056/132] (687s left) kms_atomic_transition (modeset-transition-nonblocking) [335.114493] Starting subtest: modeset-transition-nonblocking [335.116831] Starting dynamic subtest: 1x-outputs [346.059210] Dynamic subtest 1x-outputs: SUCCESS (10.789s) [346.061952] Subtest modeset-transition-nonblocking: SUCCESS (10.790s) [346.941059] [057/132] (675s left) kms_cursor_legacy (flip-vs-cursor-varying-size) [347.064048] Starting subtest: flip-vs-cursor-varying-size [356.175122] Subtest flip-vs-cursor-varying-size: SUCCESS (9.081s) [357.003317] [058/132] (665s left) kms_universal_plane (universal-plane-sanity) [357.097266] Starting subtest: universal-plane-sanity [357.099586] Starting dynamic subtest: pipe-A-eDP-1 [357.707647] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.610s) [357.718173] Starting dynamic subtest: pipe-B-eDP-1 [358.932421] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.221s) [358.945759] Starting dynamic subtest: pipe-C-eDP-1 [360.146624] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.210s) [360.159224] Starting dynamic subtest: pipe-D-eDP-1 [361.379874] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.230s) [361.382243] Subtest universal-plane-sanity: SUCCESS (4.276s) [362.234211] [059/132] (660s left) kms_psr2_sf (fbc-pr-cursor-plane-move-continuous-exceed-sf) [362.332041] Starting subtest: fbc-pr-cursor-plane-move-continuous-exceed-sf [362.336327] Subtest fbc-pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [362.398787] [060/132] (660s left) kms_busy (basic-hang) [362.507030] Starting subtest: basic-hang [362.509028] Starting dynamic subtest: flip-pipe-A [363.097443] Dynamic subtest flip-pipe-A: SUCCESS (0.590s) [363.108877] Starting dynamic subtest: modeset-pipe-A [366.578263] Dynamic subtest modeset-pipe-A: SUCCESS (3.477s) [366.587752] Starting dynamic subtest: flip-pipe-D [367.769299] Dynamic subtest flip-pipe-D: SUCCESS (1.188s) [367.778944] Starting dynamic subtest: modeset-pipe-D [371.204425] Dynamic subtest modeset-pipe-D: SUCCESS (3.434s) [371.206857] Subtest basic-hang: SUCCESS (8.695s) [372.004539] [061/132] (650s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [372.111665] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [372.116097] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [372.206382] [062/132] (650s left) gem_exec_parallel (fds) [372.263139] Starting subtest: fds [372.265486] Starting dynamic subtest: rcs0 [374.978745] Dynamic subtest rcs0: SUCCESS (2.713s) [374.988072] Starting dynamic subtest: bcs0 [378.392602] Dynamic subtest bcs0: SUCCESS (3.412s) [378.403758] Starting dynamic subtest: vcs0 [382.658953] Dynamic subtest vcs0: SUCCESS (4.262s) [382.671214] Starting dynamic subtest: vcs1 [386.586450] Dynamic subtest vcs1: SUCCESS (3.925s) [386.596650] Starting dynamic subtest: vecs0 [390.645185] Dynamic subtest vecs0: SUCCESS (4.054s) [390.658155] Starting dynamic subtest: ccs0 [394.278814] Dynamic subtest ccs0: SUCCESS (3.630s) [394.281790] Subtest fds: SUCCESS (22.008s) [394.476185] [063/132] (628s left) gem_mmap_wc (close) [394.529177] Subtest close: SKIP (0.000s) [394.587436] [064/132] (628s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt) [394.691243] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt [394.695809] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [394.814484] [065/132] (628s left) gen9_exec_parse (bb-large) [394.868462] Subtest bb-large: SKIP (0.000s) [394.945574] [066/132] (628s left) kms_cdclk (mode-transition) [395.038043] Starting subtest: mode-transition [395.040265] Starting dynamic subtest: pipe-A-eDP-1 [395.328011] Dynamic subtest pipe-A-eDP-1: SKIP (0.287s) [395.338606] Starting dynamic subtest: pipe-B-eDP-1 [395.343305] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [395.353936] Starting dynamic subtest: pipe-C-eDP-1 [395.358601] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [395.367979] Starting dynamic subtest: pipe-D-eDP-1 [395.372225] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [395.376490] Subtest mode-transition: SKIP (0.294s) [396.146499] [067/132] (626s left) gem_exec_reloc (basic-cpu-active) [396.207464] Subtest basic-cpu-active: SKIP (0.000s) [396.278664] [068/132] (626s left) gem_fenced_exec_thrash (no-spare-fences-interruptible) [396.335994] Subtest no-spare-fences-interruptible: SKIP (0.000s) [396.399535] [069/132] (626s left) i915_pm_freq_api (freq-reset) [396.471189] Starting subtest: freq-reset [396.473101] Starting dynamic subtest: gt0 [396.664886] Dynamic subtest gt0: SUCCESS (0.195s) [396.676698] Starting dynamic subtest: gt1 [396.835710] Dynamic subtest gt1: SUCCESS (0.166s) [396.838265] Subtest freq-reset: SUCCESS (0.363s) [396.906373] [070/132] (626s left) perf_pmu (interrupts-sync) [396.948763] Starting subtest: interrupts-sync [398.096456] Subtest interrupts-sync: SUCCESS (1.146s) [398.214329] [FACT perf_pmu (interrupts-sync)] new: kernel.kmod_is_loaded.vgem: true [398.217766] [071/132] (624s left) gem_madvise (dontneed-after-mmap) [398.256388] Starting subtest: dontneed-after-mmap [398.283250] Subtest dontneed-after-mmap: SUCCESS (0.027s) [398.399264] [072/132] (624s left) kms_cursor_crc (cursor-rapid-movement-64x21) [398.597120] Starting subtest: cursor-rapid-movement-64x21 [398.642676] Subtest cursor-rapid-movement-64x21: SKIP (0.043s) [398.918636] [073/132] (624s left) kms_psr (psr-dpms) [399.017224] Starting subtest: psr-dpms [399.019408] Starting dynamic subtest: eDP-1 [401.986728] Dynamic subtest eDP-1: SUCCESS (2.970s) [401.989161] Subtest psr-dpms: SUCCESS (2.971s) [402.849144] [074/132] (620s left) gem_exec_fence (invalid-fence-array) [403.275574] Starting subtest: invalid-fence-array [403.278197] Subtest invalid-fence-array: SUCCESS (0.002s) [404.437690] [075/132] (618s left) kms_flip (dpms-vs-vblank-race-interruptible) [404.546357] Starting subtest: dpms-vs-vblank-race-interruptible [404.548823] Starting dynamic subtest: A-eDP1 [409.556536] Dynamic subtest A-eDP1: SUCCESS (5.007s) [409.569324] Starting dynamic subtest: B-eDP1 [414.153865] Dynamic subtest B-eDP1: SUCCESS (4.590s) [414.164803] Starting dynamic subtest: C-eDP1 [418.773946] Dynamic subtest C-eDP1: SUCCESS (4.614s) [418.785449] Starting dynamic subtest: D-eDP1 [423.405769] Dynamic subtest D-eDP1: SUCCESS (4.628s) [423.410130] Subtest dpms-vs-vblank-race-interruptible: SUCCESS (18.856s) [424.280935] [076/132] (599s left) gem_exec_schedule (wide) [424.473941] Starting subtest: wide [424.476218] Starting dynamic subtest: rcs0 [435.010216] Dynamic subtest rcs0: SUCCESS (10.533s) [435.025623] Starting dynamic subtest: vcs0 [445.722003] Dynamic subtest vcs0: SUCCESS (10.715s) [445.735862] Starting dynamic subtest: vcs1 [457.391729] Dynamic subtest vcs1: SUCCESS (11.670s) [457.409775] Starting dynamic subtest: vecs0 [468.766896] Dynamic subtest vecs0: SUCCESS (11.371s) [468.780544] Starting dynamic subtest: ccs0 [482.194165] Dynamic subtest ccs0: SUCCESS (13.424s) [482.196888] Subtest wide: SUCCESS (57.721s) [483.809005] [077/132] (539s left) syncobj_eventfd (binary-wait-before-signal) [483.871011] Starting subtest: binary-wait-before-signal [483.900775] Subtest binary-wait-before-signal: SUCCESS (0.031s) [483.987645] [078/132] (539s left) kms_cursor_legacy (flip-vs-cursor-busy-crc-atomic) [484.102507] Starting subtest: flip-vs-cursor-busy-crc-atomic [484.923666] Subtest flip-vs-cursor-busy-crc-atomic: SUCCESS (0.818s) [485.808314] [079/132] (537s left) kms_cursor_edge_walk (256x256-top-bottom) [485.917825] Starting subtest: 256x256-top-bottom [485.920075] Starting dynamic subtest: pipe-A-eDP-1 [489.379293] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.462s) [489.392384] Starting dynamic subtest: pipe-D-eDP-1 [492.497215] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.115s) [492.499528] Subtest 256x256-top-bottom: SUCCESS (6.579s) [493.305274] [080/132] (530s left) kms_psr (fbc-psr-primary-page-flip) [493.398204] Starting subtest: fbc-psr-primary-page-flip [493.400414] Starting dynamic subtest: eDP-1 [493.404404] Dynamic subtest eDP-1: SKIP (0.000s) [493.408430] Subtest fbc-psr-primary-page-flip: SKIP (0.001s) [493.473313] [081/132] (530s left) syncobj_timeline (wait-any-complex) [493.531130] Starting subtest: wait-any-complex [493.592937] Subtest wait-any-complex: SUCCESS (0.063s) [493.676339] [082/132] (529s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs) [493.767945] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs [493.770226] Starting dynamic subtest: pipe-A-eDP-1 [493.826953] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s) [493.838341] Starting dynamic subtest: pipe-B-eDP-1 [493.895544] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s) [493.908058] Starting dynamic subtest: pipe-C-eDP-1 [493.965529] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s) [493.977252] Starting dynamic subtest: pipe-D-eDP-1 [494.034288] Dynamic subtest pipe-D-eDP-1: SKIP (0.001s) [494.038423] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.009s) [495.964048] [083/132] (527s left) kms_big_fb (linear-32bpp-rotate-0) [496.063245] Starting subtest: linear-32bpp-rotate-0 [497.598053] Subtest linear-32bpp-rotate-0: SUCCESS (1.534s) [497.733742] [084/132] (525s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-pgflip-blt) [497.835740] Starting subtest: psr-1p-primscrn-indfb-pgflip-blt [505.217543] Subtest psr-1p-primscrn-indfb-pgflip-blt: SUCCESS (7.383s) [505.344398] [085/132] (518s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-indfb-plflip-blt) [505.445370] Starting subtest: fbcpsr-2p-primscrn-indfb-plflip-blt [505.449642] Subtest fbcpsr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s) [505.544988] [086/132] (518s left) gem_pwrite (basic-random) [505.612234] Subtest basic-random: SKIP (0.000s) [505.680141] [087/132] (518s left) kms_async_flips (basic-modeset-with-all-modifiers-formats) [505.768888] Starting subtest: basic-modeset-with-all-modifiers-formats [506.140759] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB8888 [506.952641] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB8888: SUCCESS (0.812s) [506.962997] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB2101010 [506.974138] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB2101010: SUCCESS (0.020s) [506.984154] Starting dynamic subtest: pipe-A-eDP-1-4-rc-ccs-XRGB16161616F [506.996575] Dynamic subtest pipe-A-eDP-1-4-rc-ccs-XRGB16161616F: SUCCESS (0.022s) [507.006530] Starting dynamic subtest: pipe-A-eDP-1-4-RGB565 [507.152188] Dynamic subtest pipe-A-eDP-1-4-RGB565: SUCCESS (0.155s) [507.162825] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB8888 [507.174300] Dynamic subtest pipe-A-eDP-1-4-XRGB8888: SUCCESS (0.021s) [507.184304] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB2101010 [507.196580] Dynamic subtest pipe-A-eDP-1-4-XRGB2101010: SUCCESS (0.022s) [507.206506] Starting dynamic subtest: pipe-A-eDP-1-4-XRGB16161616F [507.218838] Dynamic subtest pipe-A-eDP-1-4-XRGB16161616F: SUCCESS (0.022s) [507.228983] Starting dynamic subtest: pipe-A-eDP-1-4-YUYV [507.241059] Dynamic subtest pipe-A-eDP-1-4-YUYV: SUCCESS (0.021s) [507.250933] Starting dynamic subtest: pipe-A-eDP-1-4-Y210 [507.263234] Dynamic subtest pipe-A-eDP-1-4-Y210: SUCCESS (0.021s) [507.273255] Starting dynamic subtest: pipe-A-eDP-1-4-XYUV8888 [507.285548] Dynamic subtest pipe-A-eDP-1-4-XYUV8888: SUCCESS (0.021s) [507.295597] Starting dynamic subtest: pipe-A-eDP-1-4-XV30 [507.307696] Dynamic subtest pipe-A-eDP-1-4-XV30: SUCCESS (0.021s) [507.317583] Starting dynamic subtest: pipe-A-eDP-1-4-XV36 [507.330016] Dynamic subtest pipe-A-eDP-1-4-XV36: SUCCESS (0.021s) [507.339816] Starting dynamic subtest: pipe-A-eDP-1-x-RGB565 [507.485560] Dynamic subtest pipe-A-eDP-1-x-RGB565: SUCCESS (0.155s) [507.496036] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB8888 [507.507819] Dynamic subtest pipe-A-eDP-1-x-XRGB8888: SUCCESS (0.021s) [507.518065] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB2101010 [507.530044] Dynamic subtest pipe-A-eDP-1-x-XRGB2101010: SUCCESS (0.021s) [507.539778] Starting dynamic subtest: pipe-A-eDP-1-x-XRGB16161616F [507.552304] Dynamic subtest pipe-A-eDP-1-x-XRGB16161616F: SUCCESS (0.022s) [507.562171] Starting dynamic subtest: pipe-A-eDP-1-x-YUYV [507.574793] Dynamic subtest pipe-A-eDP-1-x-YUYV: SUCCESS (0.022s) [507.585072] Starting dynamic subtest: pipe-A-eDP-1-x-Y210 [507.596823] Dynamic subtest pipe-A-eDP-1-x-Y210: SUCCESS (0.021s) [507.607330] Starting dynamic subtest: pipe-A-eDP-1-x-XYUV8888 [507.619051] Dynamic subtest pipe-A-eDP-1-x-XYUV8888: SUCCESS (0.021s) [507.629330] Starting dynamic subtest: pipe-A-eDP-1-x-XV30 [507.641249] Dynamic subtest pipe-A-eDP-1-x-XV30: SUCCESS (0.022s) [507.654150] Starting dynamic subtest: pipe-A-eDP-1-x-XV36 [507.663397] Dynamic subtest pipe-A-eDP-1-x-XV36: SUCCESS (0.022s) [507.675768] Starting dynamic subtest: pipe-A-eDP-1-linear-RGB565 [507.819354] Dynamic subtest pipe-A-eDP-1-linear-RGB565: SUCCESS (0.155s) [507.829770] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB8888 [507.841614] Dynamic subtest pipe-A-eDP-1-linear-XRGB8888: SUCCESS (0.022s) [507.851271] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB2101010 [507.863612] Dynamic subtest pipe-A-eDP-1-linear-XRGB2101010: SUCCESS (0.021s) [507.873397] Starting dynamic subtest: pipe-A-eDP-1-linear-XRGB16161616F [507.886102] Dynamic subtest pipe-A-eDP-1-linear-XRGB16161616F: SUCCESS (0.022s) [507.895996] Starting dynamic subtest: pipe-A-eDP-1-linear-YUYV [507.908265] Dynamic subtest pipe-A-eDP-1-linear-YUYV: SUCCESS (0.021s) [507.918026] Starting dynamic subtest: pipe-A-eDP-1-linear-Y210 [507.930627] Dynamic subtest pipe-A-eDP-1-linear-Y210: SUCCESS (0.021s) [507.940261] Starting dynamic subtest: pipe-A-eDP-1-linear-XYUV8888 [507.952280] Dynamic subtest pipe-A-eDP-1-linear-XYUV8888: SUCCESS (0.021s) [507.961735] Starting dynamic subtest: pipe-A-eDP-1-linear-XV30 [507.974628] Dynamic subtest pipe-A-eDP-1-linear-XV30: SUCCESS (0.021s) [507.983913] Starting dynamic subtest: pipe-A-eDP-1-linear-XV36 [507.996631] Dynamic subtest pipe-A-eDP-1-linear-XV36: SUCCESS (0.021s) [508.386336] Subtest basic-modeset-with-all-modifiers-formats: SUCCESS (2.619s) [509.256092] [088/132] (514s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling) [509.343832] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling [509.348088] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-downscaling: SKIP (0.000s) [509.430898] [089/132] (514s left) kms_ccs (crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc) [509.523188] Starting subtest: crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc [509.525443] Starting dynamic subtest: pipe-A-eDP-1 [509.546814] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [509.558369] Starting dynamic subtest: pipe-B-eDP-1 [509.578810] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [509.588548] Starting dynamic subtest: pipe-C-eDP-1 [509.608779] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [509.618062] Starting dynamic subtest: pipe-D-eDP-1 [509.638701] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [509.642824] Subtest crc-primary-rotation-180-y-tiled-gen12-rc-ccs-cc: SKIP (0.006s) [511.794386] [090/132] (512s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-indfb-pgflip-blt) [511.886599] Starting subtest: fbc-2p-scndscrn-indfb-pgflip-blt [511.890606] Subtest fbc-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [511.998428] [091/132] (512s left) perf (gen12-group-exclusive-stream-sample-oa) [512.119871] Starting subtest: gen12-group-exclusive-stream-sample-oa [512.141216] Subtest gen12-group-exclusive-stream-sample-oa: SUCCESS (0.020s) [512.190156] [092/132] (511s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-shrfb-plflip-blt) [512.288424] Starting subtest: fbcpsr-2p-primscrn-shrfb-plflip-blt [512.292628] Subtest fbcpsr-2p-primscrn-shrfb-plflip-blt: SKIP (0.000s) [512.398069] [093/132] (511s left) i915_pm_rpm (reg-read-ioctl) [514.531536] Starting subtest: reg-read-ioctl [516.924828] Subtest reg-read-ioctl: SUCCESS (2.395s) [517.309620] [094/132] (506s left) gem_lmem_swapping (parallel-random) [517.350102] Subtest parallel-random: SKIP (0.000s) [517.393859] [095/132] (506s left) kms_color (ctm-0-75) [517.478233] Starting subtest: ctm-0-75 [517.480406] Starting dynamic subtest: pipe-A-eDP-1 [522.446903] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.964s) [522.458337] Starting dynamic subtest: pipe-B-eDP-1 [527.996833] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.549s) [528.008302] Starting dynamic subtest: pipe-C-eDP-1 [533.270689] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.269s) [533.281848] Starting dynamic subtest: pipe-D-eDP-1 [538.589144] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.317s) [538.591405] Subtest ctm-0-75: SUCCESS (21.102s) [539.420280] [096/132] (484s left) kms_lease (possible-crtcs-filtering) [539.522338] Starting subtest: possible-crtcs-filtering [539.527055] Subtest possible-crtcs-filtering: SUCCESS (0.005s) [539.650594] [097/132] (484s left) syncobj_wait (single-wait-all-for-submit-unsubmitted) [539.712130] Starting subtest: single-wait-all-for-submit-unsubmitted [539.820784] Subtest single-wait-all-for-submit-unsubmitted: SUCCESS (0.108s) [539.912134] [098/132] (484s left) kms_psr (psr2-sprite-render) [540.002365] Starting subtest: psr2-sprite-render [540.004669] Starting dynamic subtest: eDP-1 [541.711994] Dynamic subtest eDP-1: SUCCESS (1.708s) [541.714623] Subtest psr2-sprite-render: SUCCESS (1.709s) [542.576105] [099/132] (481s left) syncobj_timeline (signal-array) [542.638238] Starting subtest: signal-array [542.640613] Subtest signal-array: SUCCESS (0.000s) [542.741514] [100/132] (481s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-pwrite) [542.836873] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-pwrite [549.631091] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.796s) [549.748413] [101/132] (474s left) kms_draw_crc (draw-method-mmap-cpu) [549.842071] Starting subtest: draw-method-mmap-cpu [549.843941] Starting dynamic subtest: xrgb8888-untiled [550.107040] Dynamic subtest xrgb8888-untiled: SUCCESS (0.267s) [550.117835] Starting dynamic subtest: rgb565-untiled [550.330013] Dynamic subtest rgb565-untiled: SUCCESS (0.222s) [550.340900] Starting dynamic subtest: xrgb2101010-untiled [550.551630] Dynamic subtest xrgb2101010-untiled: SUCCESS (0.221s) [550.562947] Starting dynamic subtest: xbgr16161616f-untiled [550.785214] Dynamic subtest xbgr16161616f-untiled: SUCCESS (0.232s) [550.798166] Starting dynamic subtest: xrgb8888-xtiled [550.918023] Dynamic subtest xrgb8888-xtiled: SUCCESS (0.132s) [550.930220] Starting dynamic subtest: rgb565-xtiled [551.062726] Dynamic subtest rgb565-xtiled: SUCCESS (0.142s) [551.073348] Starting dynamic subtest: xrgb2101010-xtiled [551.196063] Dynamic subtest xrgb2101010-xtiled: SUCCESS (0.132s) [551.207883] Starting dynamic subtest: xbgr16161616f-xtiled [551.318480] Dynamic subtest xbgr16161616f-xtiled: SUCCESS (0.122s) [551.329237] Starting dynamic subtest: xrgb8888-4tiled [551.462680] Dynamic subtest xrgb8888-4tiled: SUCCESS (0.143s) [551.473241] Starting dynamic subtest: rgb565-4tiled [551.607506] Dynamic subtest rgb565-4tiled: SUCCESS (0.144s) [551.620995] Starting dynamic subtest: xrgb2101010-4tiled [551.740789] Dynamic subtest xrgb2101010-4tiled: SUCCESS (0.131s) [551.751201] Starting dynamic subtest: xbgr16161616f-4tiled [551.885520] Dynamic subtest xbgr16161616f-4tiled: SUCCESS (0.144s) [551.887374] Subtest draw-method-mmap-cpu: SUCCESS (2.045s) [551.981406] [102/132] (472s left) kms_flip (2x-flip-vs-fences) [552.078650] Starting subtest: 2x-flip-vs-fences [552.082281] Subtest 2x-flip-vs-fences: SKIP (0.000s) [552.189093] [103/132] (472s left) kms_big_fb (4-tiled-64bpp-rotate-270) [552.294864] Starting subtest: 4-tiled-64bpp-rotate-270 [552.316614] Subtest 4-tiled-64bpp-rotate-270: SKIP (0.021s) [552.438366] [104/132] (472s left) gem_userptr_blits (unsync-unmap) [552.507684] Subtest unsync-unmap: SKIP (0.000s) [552.635732] [105/132] (472s left) syncobj_timeline (invalid-multi-wait-unsubmitted-signaled) [552.681041] Starting subtest: invalid-multi-wait-unsubmitted-signaled [552.682892] Subtest invalid-multi-wait-unsubmitted-signaled: SUCCESS (0.000s) [552.781979] [106/132] (471s left) gem_mmap_gtt (cpuset-big-copy) [552.826224] Subtest cpuset-big-copy: SKIP (0.000s) [552.887223] [107/132] (471s left) kms_plane_scaling (plane-scaler-unity-scaling-with-modifiers) [552.979450] Starting subtest: plane-scaler-unity-scaling-with-modifiers [552.981093] Starting dynamic subtest: pipe-A [553.328156] Dynamic subtest pipe-A: SUCCESS (0.350s) [553.345666] Starting dynamic subtest: pipe-B [554.705517] Dynamic subtest pipe-B: SUCCESS (1.374s) [554.716584] Starting dynamic subtest: pipe-C [556.146868] Dynamic subtest pipe-C: SUCCESS (1.440s) [556.158511] Starting dynamic subtest: pipe-D [557.567218] Dynamic subtest pipe-D: SUCCESS (1.419s) [557.569453] Subtest plane-scaler-unity-scaling-with-modifiers: SUCCESS (4.589s) [558.738831] [108/132] (466s left) gem_pread (display) [558.801269] Subtest display: SKIP (0.000s) [558.865533] [109/132] (465s left) gem_fence_thrash (bo-write-verify-none) [558.899588] Starting subtest: bo-write-verify-none [558.918325] Subtest bo-write-verify-none: SKIP (0.017s) [558.983929] [110/132] (465s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [559.073829] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [560.208160] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SUCCESS (1.135s) [560.343437] [111/132] (464s left) perf_pmu (idle) [560.381554] Starting subtest: idle [560.383830] Starting dynamic subtest: rcs0 [560.938687] Dynamic subtest rcs0: SUCCESS (0.555s) [560.951076] Starting dynamic subtest: bcs0 [561.455360] Dynamic subtest bcs0: SUCCESS (0.514s) [561.468360] Starting dynamic subtest: vcs0 [561.974284] Dynamic subtest vcs0: SUCCESS (0.516s) [561.986423] Starting dynamic subtest: vcs1 [562.491255] Dynamic subtest vcs1: SUCCESS (0.514s) [562.504386] Starting dynamic subtest: vecs0 [563.007175] Dynamic subtest vecs0: SUCCESS (0.513s) [563.018294] Starting dynamic subtest: ccs0 [563.522454] Dynamic subtest ccs0: SUCCESS (0.512s) [563.525182] Subtest idle: SUCCESS (3.142s) [563.627851] [112/132] (461s left) kms_ccs (ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc) [563.723644] Starting subtest: ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc [563.726040] Starting dynamic subtest: pipe-A-eDP-1 [563.747616] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [563.760905] Starting dynamic subtest: pipe-B-eDP-1 [563.780294] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [563.790824] Starting dynamic subtest: pipe-C-eDP-1 [563.810129] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [563.820958] Starting dynamic subtest: pipe-D-eDP-1 [563.840301] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [563.842576] Subtest ccs-on-another-bo-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.008s) [565.910294] [113/132] (459s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-render) [566.022659] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-render [572.872903] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.853s) [573.026737] [114/132] (452s left) gem_ctx_bad_destroy (invalid-pad) [573.089078] Starting subtest: invalid-pad [573.091304] Subtest invalid-pad: SUCCESS (0.000s) [573.165568] [115/132] (451s left) gem_exec_schedule (pi-userfault) [573.336560] Starting subtest: pi-userfault [573.339009] Starting dynamic subtest: rcs0 [573.347070] Dynamic subtest rcs0: SUCCESS (0.011s) [573.360675] Starting dynamic subtest: bcs0 [573.362658] Dynamic subtest bcs0: SUCCESS (0.008s) [573.373372] Starting dynamic subtest: vcs0 [573.375748] Dynamic subtest vcs0: SUCCESS (0.009s) [573.386509] Starting dynamic subtest: vcs1 [573.388775] Dynamic subtest vcs1: SUCCESS (0.008s) [573.399533] Starting dynamic subtest: vecs0 [573.401491] Dynamic subtest vecs0: SUCCESS (0.010s) [573.411860] Starting dynamic subtest: ccs0 [573.413904] Dynamic subtest ccs0: SUCCESS (0.009s) [573.415910] Subtest pi-userfault: SUCCESS (0.059s) [573.593985] [116/132] (451s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [573.694795] Starting subtest: primary-y-tiled-reflect-x-0 [573.754851] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s) [573.873191] [117/132] (451s left) kms_frontbuffer_tracking (psr-2p-scndscrn-shrfb-msflip-blt) [573.964274] Starting subtest: psr-2p-scndscrn-shrfb-msflip-blt [573.968668] Subtest psr-2p-scndscrn-shrfb-msflip-blt: SKIP (0.000s) [574.065825] [118/132] (451s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-render) [574.174670] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-render [574.178799] Subtest psr-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [574.271333] [119/132] (451s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [574.375951] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [574.378033] Starting dynamic subtest: pipe-A-eDP-1 [581.205547] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.833s) [581.216451] Starting dynamic subtest: pipe-B-eDP-1 [588.284962] Dynamic subtest pipe-B-eDP-1: SUCCESS (7.081s) [588.287164] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.916s) [589.142965] [120/132] (436s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-onoff) [589.252374] Starting subtest: psr-1p-primscrn-spr-indfb-onoff [596.347406] Subtest psr-1p-primscrn-spr-indfb-onoff: SUCCESS (7.097s) [596.466640] [121/132] (428s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [596.569679] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [596.573744] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [596.667032] [122/132] (428s left) gem_exec_reloc (basic-wc-gtt-active) [596.728696] Subtest basic-wc-gtt-active: SKIP (0.000s) [596.806125] [123/132] (428s left) kms_chamelium_hpd (vga-hpd-fast) [597.205112] Subtest vga-hpd-fast: SKIP (0.000s) [597.988183] [124/132] (427s left) i915_pm_rps (thresholds) [598.041823] Starting subtest: thresholds [598.046433] Subtest thresholds: SKIP (0.000s) [598.136991] [125/132] (427s left) syncobj_wait (multi-wait-signaled) [598.193012] Starting subtest: multi-wait-signaled [598.195271] Subtest multi-wait-signaled: SUCCESS (0.000s) [598.295983] [126/132] (427s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format) [598.392209] Starting subtest: plane-upscale-20x20-with-pixel-format [598.394472] Starting dynamic subtest: pipe-A [599.439647] Dynamic subtest pipe-A: SUCCESS (1.050s) [599.452456] Starting dynamic subtest: pipe-B [601.607734] Dynamic subtest pipe-B: SUCCESS (2.165s) [601.618785] Starting dynamic subtest: pipe-C [602.796106] Dynamic subtest pipe-C: SUCCESS (1.187s) [602.809654] Starting dynamic subtest: pipe-D [604.029560] Dynamic subtest pipe-D: SUCCESS (1.233s) [604.031831] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.642s) [605.231780] [127/132] (420s left) gem_busy (semaphore) [605.414524] Subtest semaphore: SKIP (0.000s) [605.648410] [128/132] (420s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [605.740475] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [605.744897] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [605.838835] [129/132] (419s left) api_intel_bb (bb-with-allocator) [605.897108] Starting subtest: bb-with-allocator [605.901909] Subtest bb-with-allocator: SUCCESS (0.006s) [606.023716] [130/132] (419s left) kms_psr2_sf (pr-cursor-plane-move-continuous-exceed-sf) [606.125635] Starting subtest: pr-cursor-plane-move-continuous-exceed-sf [606.129608] Subtest pr-cursor-plane-move-continuous-exceed-sf: SKIP (0.000s) [606.198813] [131/132] (419s left) sysfs_timeslice_duration (idempotent) [606.254329] Starting subtest: idempotent [606.256728] Starting dynamic subtest: vecs0 [606.259114] Dynamic subtest vecs0: SUCCESS (0.000s) [606.273184] Starting dynamic subtest: ccs0 [606.275079] Dynamic subtest ccs0: SUCCESS (0.000s) [606.285405] Starting dynamic subtest: vcs0 [606.287249] Dynamic subtest vcs0: SUCCESS (0.000s) [606.297431] Starting dynamic subtest: bcs0 [606.299340] Dynamic subtest bcs0: SUCCESS (0.000s) [606.309247] Starting dynamic subtest: rcs0 [606.311176] Dynamic subtest rcs0: SUCCESS (0.000s) [606.321663] Starting dynamic subtest: vcs1 [606.323959] Dynamic subtest vcs1: SUCCESS (0.000s) [606.326289] Subtest idempotent: SUCCESS (0.006s) [606.376592] [132/132] (419s left) kms_vblank (query-forked) [606.470026] Starting subtest: query-forked [606.471891] Starting dynamic subtest: pipe-A-eDP-1 [608.305726] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.836s) [608.334115] Starting dynamic subtest: pipe-D-eDP-1 [610.838860] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.529s) [610.841383] Subtest query-forked: SUCCESS (4.370s) [611.707592] Closing watchdogs results: parsing output: 0/ for test: gem_exec_reloc results: parsing output: 1/ for test: gem_exec_params results: parsing output: 2/ for test: kms_addfb_basic results: parsing output: 3/ for test: gem_exec_schedule results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_pipe_stress results: parsing output: 6/ for test: gem_exec_schedule results: parsing output: 7/ for test: gem_exec_suspend results: parsing output: 8/ for test: kms_cursor_legacy results: parsing output: 9/ for test: gem_exec_async results: parsing output: 10/ for test: kms_big_fb results: parsing output: 11/ for test: kms_properties results: parsing output: 12/ for test: kms_big_fb results: parsing output: 13/ for test: kms_psr results: parsing output: 14/ for test: i915_drm_fdinfo results: parsing output: 15/ for test: gem_mmap_gtt results: parsing output: 16/ for test: syncobj_timeline results: parsing output: 17/ for test: gem_mmap_gtt results: parsing output: 18/ for test: kms_flip_scaled_crc results: parsing output: 19/ for test: gem_pxp results: parsing output: 20/ for test: syncobj_wait results: parsing output: 21/ for test: gem_exec_balancer results: parsing output: 22/ for test: gem_softpin results: parsing output: 23/ for test: syncobj_eventfd results: parsing output: 24/ for test: gem_exec_reloc results: parsing output: 25/ for test: kms_plane results: parsing output: 26/ for test: kms_addfb_basic results: parsing output: 27/ for test: gem_userptr_blits results: parsing output: 28/ for test: kms_frontbuffer_tracking results: parsing output: 29/ for test: gem_exec_params results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_pm_backlight results: parsing output: 32/ for test: kms_chamelium_color results: parsing output: 33/ for test: gem_render_copy results: parsing output: 34/ for test: gem_sync results: parsing output: 35/ for test: kms_cursor_crc results: parsing output: 36/ for test: gem_mmap_wc results: parsing output: 37/ for test: core_getversion results: parsing output: 38/ for test: gem_create results: parsing output: 39/ for test: kms_invalid_mode results: parsing output: 40/ for test: gem_exec_capture results: parsing output: 41/ for test: kms_plane results: parsing output: 42/ for test: kms_addfb_basic results: parsing output: 43/ for test: kms_getfb results: parsing output: 44/ for test: gem_ctx_persistence results: parsing output: 45/ for test: kms_ccs results: parsing output: 46/ for test: kms_cursor_legacy results: parsing output: 47/ for test: gem_request_retire results: parsing output: 48/ for test: kms_content_protection results: parsing output: 49/ for test: kms_flip results: parsing output: 50/ for test: api_intel_bb results: parsing output: 51/ for test: kms_big_fb results: parsing output: 52/ for test: kms_psr results: parsing output: 53/ for test: gem_ctx_isolation results: parsing output: 54/ for test: gem_partial_pwrite_pread results: parsing output: 55/ for test: kms_atomic_transition results: parsing output: 56/ for test: kms_cursor_legacy results: parsing output: 57/ for test: kms_universal_plane results: parsing output: 58/ for test: kms_psr2_sf results: parsing output: 59/ for test: kms_busy results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: gem_exec_parallel results: parsing output: 62/ for test: gem_mmap_wc results: parsing output: 63/ for test: kms_frontbuffer_tracking results: parsing output: 64/ for test: gen9_exec_parse results: parsing output: 65/ for test: kms_cdclk results: parsing output: 66/ for test: gem_exec_reloc results: parsing output: 67/ for test: gem_fenced_exec_thrash results: parsing output: 68/ for test: i915_pm_freq_api results: parsing output: 69/ for test: perf_pmu results: parsing output: 70/ for test: gem_madvise results: parsing output: 71/ for test: kms_cursor_crc results: parsing output: 72/ for test: kms_psr results: parsing output: 73/ for test: gem_exec_fence results: parsing output: 74/ for test: kms_flip results: parsing output: 75/ for test: gem_exec_schedule results: parsing output: 76/ for test: syncobj_eventfd results: parsing output: 77/ for test: kms_cursor_legacy results: parsing output: 78/ for test: kms_cursor_edge_walk results: parsing output: 79/ for test: kms_psr results: parsing output: 80/ for test: syncobj_timeline results: parsing output: 81/ for test: kms_ccs results: parsing output: 82/ for test: kms_big_fb results: parsing output: 83/ for test: kms_frontbuffer_tracking results: parsing output: 84/ for test: kms_frontbuffer_tracking results: parsing output: 85/ for test: gem_pwrite results: parsing output: 86/ for test: kms_async_flips results: parsing output: 87/ for test: kms_flip_scaled_crc results: parsing output: 88/ for test: kms_ccs results: parsing output: 89/ for test: kms_frontbuffer_tracking results: parsing output: 90/ for test: perf results: parsing output: 91/ for test: kms_frontbuffer_tracking results: parsing output: 92/ for test: i915_pm_rpm results: parsing output: 93/ for test: gem_lmem_swapping results: parsing output: 94/ for test: kms_color results: parsing output: 95/ for test: kms_lease results: parsing output: 96/ for test: syncobj_wait results: parsing output: 97/ for test: kms_psr results: parsing output: 98/ for test: syncobj_timeline results: parsing output: 99/ for test: kms_frontbuffer_tracking results: parsing output: 100/ for test: kms_draw_crc results: parsing output: 101/ for test: kms_flip results: parsing output: 102/ for test: kms_big_fb results: parsing output: 103/ for test: gem_userptr_blits results: parsing output: 104/ for test: syncobj_timeline results: parsing output: 105/ for test: gem_mmap_gtt results: parsing output: 106/ for test: kms_plane_scaling results: parsing output: 107/ for test: gem_pread results: parsing output: 108/ for test: gem_fence_thrash results: parsing output: 109/ for test: kms_big_fb results: parsing output: 110/ for test: perf_pmu results: parsing output: 111/ for test: kms_ccs results: parsing output: 112/ for test: kms_frontbuffer_tracking results: parsing output: 113/ for test: gem_ctx_bad_destroy results: parsing output: 114/ for test: gem_exec_schedule results: parsing output: 115/ for test: kms_rotation_crc results: parsing output: 116/ for test: kms_frontbuffer_tracking results: parsing output: 117/ for test: kms_frontbuffer_tracking results: parsing output: 118/ for test: kms_psr2_sf results: parsing output: 119/ for test: kms_frontbuffer_tracking results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_exec_reloc results: parsing output: 122/ for test: kms_chamelium_hpd results: parsing output: 123/ for test: i915_pm_rps results: parsing output: 124/ for test: syncobj_wait results: parsing output: 125/ for test: kms_plane_scaling results: parsing output: 126/ for test: gem_busy results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: api_intel_bb results: parsing output: 129/ for test: kms_psr2_sf results: parsing output: 130/ for test: sysfs_timeslice_duration results: parsing output: 131/ for test: kms_vblank Done.