[55.189178] Initializing watchdogs
[55.189227]   /dev/watchdog0
[55.204354] [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]
[55.208729] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[55.211223] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[55.214854] [001/131] (960s left) perf_pmu (most-busy-idle-check-all)
[55.275098] Starting subtest: most-busy-idle-check-all
[55.277240] Starting dynamic subtest: rcs0
[56.916431] Dynamic subtest rcs0: SUCCESS (1.618s)
[56.929321] Starting dynamic subtest: bcs0
[58.900752] Dynamic subtest bcs0: SUCCESS (1.964s)
[58.910965] Starting dynamic subtest: vcs0
[60.883965] Dynamic subtest vcs0: SUCCESS (1.967s)
[60.894064] Starting dynamic subtest: vcs1
[62.932309] Dynamic subtest vcs1: SUCCESS (2.036s)
[62.942848] Starting dynamic subtest: vecs0
[64.915802] Dynamic subtest vecs0: SUCCESS (1.974s)
[64.924001] Starting dynamic subtest: ccs0
[66.899928] Dynamic subtest ccs0: SUCCESS (1.976s)
[66.902179] Subtest most-busy-idle-check-all: SUCCESS (11.537s)
[67.006442] [002/131] (948s left) syncobj_wait (multi-wait-submitted)
[67.064147] Starting subtest: multi-wait-submitted
[67.168338] Subtest multi-wait-submitted: SUCCESS (0.104s)
[67.240062] [003/131] (948s left) gem_wait (write-wait)
[67.302391] Starting subtest: write-wait
[67.304685] Starting dynamic subtest: all-engines
[68.463654] Dynamic subtest all-engines: SUCCESS (1.158s)
[68.477849] Starting dynamic subtest: rcs0
[69.523365] Dynamic subtest rcs0: SUCCESS (1.056s)
[69.538058] Starting dynamic subtest: bcs0
[70.580070] Dynamic subtest bcs0: SUCCESS (1.055s)
[70.594273] Starting dynamic subtest: vcs0
[71.679734] Dynamic subtest vcs0: SUCCESS (1.098s)
[71.694291] Starting dynamic subtest: vcs1
[72.733071] Dynamic subtest vcs1: SUCCESS (1.051s)
[72.745940] Starting dynamic subtest: vecs0
[73.785911] Dynamic subtest vecs0: SUCCESS (1.051s)
[73.799275] Starting dynamic subtest: ccs0
[74.842028] Dynamic subtest ccs0: SUCCESS (1.054s)
[74.844596] Subtest write-wait: SUCCESS (7.526s)
[75.035551] [FACT gem_wait (write-wait)] new: kernel.kmod_is_loaded.vgem: true
[75.038698] [004/131] (940s left) kms_plane_lowres (tiling-4)
[75.146512] Starting subtest: tiling-4
[75.148986] Starting dynamic subtest: pipe-A-eDP-1
[75.153791] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[75.454840] Starting dynamic subtest: pipe-B-eDP-1
[75.459587] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[75.466541] Starting dynamic subtest: pipe-C-eDP-1
[75.471557] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[75.478704] Starting dynamic subtest: pipe-D-eDP-1
[75.483045] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[75.487247] Subtest tiling-4: SKIP (0.305s)
[76.286561] [005/131] (939s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[76.388039] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[83.029917] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SUCCESS (6.639s)
[83.160590] [006/131] (932s left) gem_exec_fence (basic-await)
[83.351370] Starting subtest: basic-await
[83.353912] Starting dynamic subtest: rcs0
[83.426139] Dynamic subtest rcs0: SUCCESS (0.075s)
[83.436234] Starting dynamic subtest: bcs0
[83.497999] Dynamic subtest bcs0: SUCCESS (0.071s)
[83.507985] Starting dynamic subtest: vcs0
[83.569215] Dynamic subtest vcs0: SUCCESS (0.071s)
[83.579429] Starting dynamic subtest: vcs1
[83.641379] Dynamic subtest vcs1: SUCCESS (0.072s)
[83.651053] Starting dynamic subtest: vecs0
[83.716970] Dynamic subtest vecs0: SUCCESS (0.075s)
[83.727678] Starting dynamic subtest: ccs0
[83.792548] Dynamic subtest ccs0: SUCCESS (0.076s)
[83.794992] Subtest basic-await: SUCCESS (0.442s)
[86.013049] [007/131] (929s left) syncobj_timeline (invalid-wait-illegal-handle)
[86.071429] Starting subtest: invalid-wait-illegal-handle
[86.073907] Subtest invalid-wait-illegal-handle: SUCCESS (0.000s)
[86.165569] [008/131] (929s left) gem_ctx_param (invalid-get-ringsize)
[86.216574] Starting subtest: invalid-get-ringsize
[86.218883] Subtest invalid-get-ringsize: SUCCESS (0.001s)
[86.331128] [009/131] (929s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted-signaled)
[86.388775] Starting subtest: invalid-multi-wait-unsubmitted-submitted-signaled
[86.391221] Subtest invalid-multi-wait-unsubmitted-submitted-signaled: SUCCESS (0.000s)
[86.481090] [010/131] (929s left) kms_dsc (dsc-fractional-bpp)
[86.587800] Starting subtest: dsc-fractional-bpp
[86.600837] Subtest dsc-fractional-bpp: SKIP (0.000s)
[86.656872] [011/131] (929s left) gem_render_copy (yf-tiled-to-vebox-yf-tiled)
[86.721258] Starting subtest: yf-tiled-to-vebox-yf-tiled
[86.725765] Subtest yf-tiled-to-vebox-yf-tiled: SKIP (0.000s)
[86.899602] [012/131] (929s left) gem_exec_schedule (u-submit-late-slice)
[86.976066] Starting subtest: u-submit-late-slice
[86.978505] Starting dynamic subtest: rcs0
[87.004699] Dynamic subtest rcs0: SUCCESS (0.034s)
[87.015713] Starting dynamic subtest: bcs0
[87.036757] Dynamic subtest bcs0: SUCCESS (0.032s)
[87.044616] Starting dynamic subtest: vcs0
[87.067900] Dynamic subtest vcs0: SUCCESS (0.030s)
[87.078825] Starting dynamic subtest: vcs1
[87.096712] Dynamic subtest vcs1: SUCCESS (0.030s)
[87.105568] Starting dynamic subtest: vecs0
[87.131725] Dynamic subtest vecs0: SUCCESS (0.035s)
[87.140483] Starting dynamic subtest: ccs0
[87.160678] Dynamic subtest ccs0: SUCCESS (0.029s)
[87.162972] Subtest u-submit-late-slice: SUCCESS (0.190s)
[89.026065] [013/131] (927s left) kms_psr (psr-primary-mmap-cpu)
[89.131702] Starting subtest: psr-primary-mmap-cpu
[89.134040] Starting dynamic subtest: eDP-1
[90.821800] Dynamic subtest eDP-1: SUCCESS (1.690s)
[90.824238] Subtest psr-primary-mmap-cpu: SUCCESS (1.690s)
[91.682555] [014/131] (924s left) api_intel_bb (object-reloc-purge-cache)
[91.730898] Starting subtest: object-reloc-purge-cache
[91.735626] Subtest object-reloc-purge-cache: SKIP (0.003s)
[91.820173] [015/131] (924s left) gem_create (create-massive)
[91.878990] Starting subtest: create-massive
[91.881092] Subtest create-massive: SUCCESS (0.000s)
[92.062620] [016/131] (924s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0)
[92.174843] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0
[92.179314] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0: SKIP (0.000s)
[92.270876] [017/131] (924s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs-cc)
[92.366943] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs-cc
[92.369285] Starting dynamic subtest: pipe-A-eDP-1
[92.389675] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[92.399735] Starting dynamic subtest: pipe-B-eDP-1
[92.418552] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[92.425533] Starting dynamic subtest: pipe-C-eDP-1
[92.444980] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[92.451872] Starting dynamic subtest: pipe-D-eDP-1
[92.471295] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[92.473209] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs-cc: SUCCESS (0.006s)
[94.647912] [018/131] (921s left) kms_big_fb (linear-8bpp-rotate-0)
[94.754689] Starting subtest: linear-8bpp-rotate-0
[95.911110] Subtest linear-8bpp-rotate-0: SUCCESS (1.157s)
[96.043837] [019/131] (920s left) kms_atomic (test-only)
[96.141094] Starting subtest: test-only
[96.192366] Starting dynamic subtest: pipe-A-eDP-1
[98.690174] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.499s)
[98.692599] Subtest test-only: SUCCESS (2.551s)
[99.554358] [020/131] (916s left) gem_mmap_offset (ptrace)
[99.603755] Starting subtest: ptrace
[99.608503] Starting dynamic subtest: smem0-wb
[99.619992] Dynamic subtest smem0-wb: SUCCESS (0.013s)
[99.628059] Starting dynamic subtest: smem0-wc
[99.639093] Dynamic subtest smem0-wc: SUCCESS (0.019s)
[99.646423] Starting dynamic subtest: smem0-uc
[99.657619] Dynamic subtest smem0-uc: SUCCESS (0.018s)
[99.659877] Subtest ptrace: SUCCESS (0.056s)
[99.806908] [021/131] (916s left) perf_pmu (busy-double-start)
[99.841100] Starting subtest: busy-double-start
[99.843253] Starting dynamic subtest: rcs0
[103.480538] Dynamic subtest rcs0: FAIL (3.587s)
[103.489864] Starting dynamic subtest: bcs0
[107.008042] Dynamic subtest bcs0: SUCCESS (3.577s)
[107.021541] Starting dynamic subtest: vcs0
[111.489350] Dynamic subtest vcs0: SUCCESS (4.481s)
[111.499514] Starting dynamic subtest: vcs1
[115.433198] Dynamic subtest vcs1: SUCCESS (3.942s)
[115.443484] Starting dynamic subtest: vecs0
[119.470811] Dynamic subtest vecs0: SUCCESS (4.037s)
[119.480447] Starting dynamic subtest: ccs0
[123.100662] Dynamic subtest ccs0: FAIL (3.563s)
[123.102528] Subtest busy-double-start: FAIL (23.189s)
[123.158581] [022/131] (893s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-fullscreen)
[123.262469] Starting subtest: fbc-1p-primscrn-spr-indfb-fullscreen
[127.275851] Subtest fbc-1p-primscrn-spr-indfb-fullscreen: SUCCESS (4.016s)
[128.471327] [023/131] (888s left) gem_exec_params (rsvd2-dirt)
[128.535822] Starting subtest: rsvd2-dirt
[128.540462] Subtest rsvd2-dirt: SKIP (0.000s)
[128.652391] [024/131] (887s left) api_intel_bb (object-noreloc-purge-cache-simple)
[128.714987] Starting subtest: object-noreloc-purge-cache-simple
[128.719991] Subtest object-noreloc-purge-cache-simple: SUCCESS (0.006s)
[128.857780] [025/131] (887s left) gem_userptr_blits (sync-unmap)
[128.934350] Starting subtest: sync-unmap
[128.950232] Subtest sync-unmap: SUCCESS (0.017s)
[129.084375] [026/131] (887s left) syncobj_timeline (device-signal-unordered)
[129.134038] Starting subtest: device-signal-unordered
[129.136477] Subtest device-signal-unordered: SUCCESS (0.001s)
[129.229913] [027/131] (887s left) gem_ctx_shared (q-smoketest)
[129.296357] Starting subtest: Q-smoketest
[129.298766] Starting dynamic subtest: rcs0
[134.851861] Dynamic subtest rcs0: SUCCESS (5.508s)
[134.861649] Starting dynamic subtest: bcs0
[140.331048] Dynamic subtest bcs0: SUCCESS (5.481s)
[140.338940] Starting dynamic subtest: vcs0
[145.807126] Dynamic subtest vcs0: SUCCESS (5.473s)
[145.819383] Starting dynamic subtest: vcs1
[151.295438] Dynamic subtest vcs1: SUCCESS (5.488s)
[151.304372] Starting dynamic subtest: vecs0
[156.766080] Dynamic subtest vecs0: SUCCESS (5.471s)
[156.774402] Starting dynamic subtest: ccs0
[162.269287] Dynamic subtest ccs0: SUCCESS (5.500s)
[162.271709] Subtest Q-smoketest: SUCCESS (32.922s)
[162.406650] [028/131] (854s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu)
[162.510306] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu
[162.514641] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-cpu: SKIP (0.000s)
[162.605879] [029/131] (854s left) gem_userptr_blits (map-fixed-invalidate)
[162.668848] Starting subtest: map-fixed-invalidate
[162.673397] Subtest map-fixed-invalidate: SKIP (0.000s)
[162.797940] [030/131] (854s left) gem_mmap_gtt (big-bo)
[162.859617] Subtest big-bo: SKIP (0.000s)
[162.934163] [031/131] (853s left) sw_sync (sync_busy_fork)
[162.965410] Starting subtest: sync_busy_fork
[163.978311] Subtest sync_busy_fork: SUCCESS (1.012s)
[164.043994] [032/131] (852s left) gem_mmap_wc (coherency)
[164.107037] Subtest coherency: SKIP (0.000s)
[164.171075] [033/131] (852s left) kms_cursor_edge_walk (256x256-left-edge)
[164.266023] Starting subtest: 256x256-left-edge
[164.268422] Starting dynamic subtest: pipe-A-eDP-1
[167.738971] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.474s)
[167.747809] Starting dynamic subtest: pipe-D-eDP-1
[170.844124] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.103s)
[170.846049] Subtest 256x256-left-edge: SUCCESS (6.578s)
[171.657678] [034/131] (845s left) prime_vgem (coherency-blt)
[171.743980] Starting subtest: coherency-blt
[172.837736] Subtest coherency-blt: SUCCESS (1.092s)
[172.971677] [035/131] (844s left) gem_tiled_wc
[173.104813] [036/131] (843s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-draw-pwrite)
[173.201442] Starting subtest: psr-1p-primscrn-cur-indfb-draw-pwrite
[179.868065] Subtest psr-1p-primscrn-cur-indfb-draw-pwrite: SUCCESS (6.670s)
[180.002195] [037/131] (837s left) gem_exec_fence (syncobj-invalid-flags)
[180.440080] Starting subtest: syncobj-invalid-flags
[180.442433] Subtest syncobj-invalid-flags: SUCCESS (0.000s)
[182.013152] [038/131] (835s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling)
[182.100259] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling
[182.102484] Starting dynamic subtest: pipe-A-default-mode
[182.394777] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[182.399526] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.291s)
[183.203128] [039/131] (834s left) gem_mmap_gtt (hang-user)
[183.266093] Subtest hang-user: SKIP (0.000s)
[183.330114] [040/131] (833s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[183.428844] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[183.431122] Starting dynamic subtest: pipe-A
[184.566576] Dynamic subtest pipe-A: SUCCESS (1.140s)
[184.574923] Starting dynamic subtest: pipe-B
[186.747888] Dynamic subtest pipe-B: SUCCESS (2.181s)
[186.756138] Starting dynamic subtest: pipe-C
[187.913680] Dynamic subtest pipe-C: SUCCESS (1.164s)
[187.923473] Starting dynamic subtest: pipe-D
[189.061500] Dynamic subtest pipe-D: SUCCESS (1.147s)
[189.063981] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (5.635s)
[190.250877] [041/131] (827s left) kms_chamelium_hpd (dp-hpd)
[190.631973] Subtest dp-hpd: SKIP (0.000s)
[191.456224] [042/131] (825s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[191.676857] Starting subtest: cursor-rapid-movement-128x42
[191.716683] Subtest cursor-rapid-movement-128x42: SKIP (0.034s)
[191.937315] [043/131] (825s left) sw_sync (sync_multi_consumer_producer)
[191.972017] Starting subtest: sync_multi_consumer_producer
[192.256409] Subtest sync_multi_consumer_producer: SUCCESS (0.284s)
[192.314847] [044/131] (825s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc)
[192.412064] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc
[192.416669] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[192.518807] [045/131] (824s left) kms_cursor_crc (cursor-offscreen-max-size)
[192.799789] Starting subtest: cursor-offscreen-max-size
[192.806677] Subtest cursor-offscreen-max-size: SKIP (0.000s)
[192.929757] [046/131] (824s left) kms_big_fb (yf-tiled-64bpp-rotate-90)
[193.038314] Starting subtest: yf-tiled-64bpp-rotate-90
[193.042298] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s)
[193.128156] [047/131] (824s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs-cc)
[193.223628] Starting subtest: crc-primary-basic-4-tiled-dg2-rc-ccs-cc
[193.225985] Starting dynamic subtest: pipe-A-eDP-1
[193.248413] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[193.256624] Starting dynamic subtest: pipe-B-eDP-1
[193.275556] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[193.282828] Starting dynamic subtest: pipe-C-eDP-1
[193.299856] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[193.306953] Starting dynamic subtest: pipe-D-eDP-1
[193.324800] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[193.328133] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[195.434143] [048/131] (822s left) i915_pm_sseu (full-enable)
[195.487922] Subtest full-enable: SKIP (0.000s)
[195.588330] [049/131] (822s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[195.689383] Starting subtest: bo-too-small-due-to-tiling
[195.693849] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[195.786415] [050/131] (821s left) sysfs_defaults (readonly)
[195.841462] Starting subtest: readonly
[195.843736] Starting dynamic subtest: vecs0
[195.845995] Dynamic subtest vecs0: SUCCESS (0.000s)
[195.853781] Starting dynamic subtest: ccs0
[195.855641] Dynamic subtest ccs0: SUCCESS (0.000s)
[195.862872] Starting dynamic subtest: vcs0
[195.865092] Dynamic subtest vcs0: SUCCESS (0.000s)
[195.872233] Starting dynamic subtest: bcs0
[195.874056] Dynamic subtest bcs0: SUCCESS (0.000s)
[195.881271] Starting dynamic subtest: rcs0
[195.883098] Dynamic subtest rcs0: SUCCESS (0.000s)
[195.890260] Starting dynamic subtest: vcs1
[195.892119] Dynamic subtest vcs1: SUCCESS (0.000s)
[195.893974] Subtest readonly: SUCCESS (0.004s)
[195.956159] [051/131] (821s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-180-hflip)
[196.049430] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-180-hflip
[196.053658] Subtest y-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.000s)
[196.166039] [052/131] (821s left) kms_feature_discovery (psr1)
[196.249461] Starting subtest: psr1
[196.251328] Subtest psr1: SUCCESS (0.000s)
[196.320452] [053/131] (821s left) kms_frontbuffer_tracking (psr-1p-primscrn-indfb-plflip-blt)
[196.410388] Starting subtest: psr-1p-primscrn-indfb-plflip-blt
[203.865737] Subtest psr-1p-primscrn-indfb-plflip-blt: SUCCESS (7.457s)
[203.997488] [054/131] (813s left) gem_ctx_bad_destroy (invalid-ctx)
[204.047601] Starting subtest: invalid-ctx
[204.049928] Subtest invalid-ctx: SUCCESS (0.000s)
[204.120430] [055/131] (813s left) gem_linear_blits (basic)
[204.397352] Starting subtest: basic
[204.411681] Subtest basic: SUCCESS (0.015s)
[204.553955] [056/131] (813s left) gem_exec_reloc (basic-gtt-wc-noreloc)
[204.648235] Subtest basic-gtt-wc-noreloc: SKIP (0.000s)
[204.712963] [057/131] (813s left) kms_psr2_sf (fbc-pr-overlay-primary-update-sf-dmg-area)
[209.766428] Starting subtest: fbc-pr-overlay-primary-update-sf-dmg-area
[209.771065] Subtest fbc-pr-overlay-primary-update-sf-dmg-area: SKIP (0.002s)
[210.612368] [058/131] (807s left) kms_writeback (writeback-check-output-xrgb2101010)
[210.714688] Subtest writeback-check-output-XRGB2101010: SKIP (0.000s)
[210.762339] [059/131] (807s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-async-flip)
[210.872243] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip
[211.686111] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-async-flip: SUCCESS (0.814s)
[211.897252] [060/131] (806s left) gem_ctx_param (non-root-set)
[211.952712] Starting subtest: non-root-set
[211.983907] Subtest non-root-set: SUCCESS (0.031s)
[212.075464] [061/131] (806s left) kms_psr (fbc-psr-primary-render)
[212.180271] Starting subtest: fbc-psr-primary-render
[212.182428] Starting dynamic subtest: eDP-1
[212.186698] Dynamic subtest eDP-1: SKIP (0.000s)
[212.191132] Subtest fbc-psr-primary-render: SKIP (0.001s)
[212.251753] [062/131] (805s left) syncobj_timeline (multi-wait-available-unsubmitted-submitted)
[212.317247] Starting subtest: multi-wait-available-unsubmitted-submitted
[212.319546] Subtest multi-wait-available-unsubmitted-submitted: SUCCESS (0.000s)
[212.442344] [063/131] (805s left) kms_flip (nonexisting-fb)
[212.536285] Starting subtest: nonexisting-fb
[212.538567] Starting dynamic subtest: A-eDP1
[213.711411] Dynamic subtest A-eDP1: SUCCESS (1.177s)
[213.721594] Starting dynamic subtest: B-eDP1
[214.843340] Dynamic subtest B-eDP1: SUCCESS (1.131s)
[214.851837] Starting dynamic subtest: C-eDP1
[215.977425] Dynamic subtest C-eDP1: SUCCESS (1.133s)
[215.985732] Starting dynamic subtest: D-eDP1
[217.103058] Dynamic subtest D-eDP1: SUCCESS (1.125s)
[217.105443] Subtest nonexisting-fb: SUCCESS (4.573s)
[218.276622] [064/131] (799s left) gem_spin_batch (resubmit-new-all)
[218.348296] Starting subtest: resubmit-new-all
[218.350608] Starting dynamic subtest: rcs0
[218.361589] Dynamic subtest rcs0: SUCCESS (0.013s)
[218.370226] Starting dynamic subtest: bcs0
[218.375598] Dynamic subtest bcs0: SUCCESS (0.013s)
[218.387821] Starting dynamic subtest: vcs0
[218.390243] Dynamic subtest vcs0: SUCCESS (0.012s)
[218.398079] Starting dynamic subtest: vcs1
[218.400297] Dynamic subtest vcs1: SUCCESS (0.009s)
[218.408472] Starting dynamic subtest: vecs0
[218.410865] Dynamic subtest vecs0: SUCCESS (0.009s)
[218.419577] Starting dynamic subtest: ccs0
[218.421492] Dynamic subtest ccs0: SUCCESS (0.009s)
[218.423408] Subtest resubmit-new-all: SUCCESS (0.069s)
[219.961321] [065/131] (798s left) syncobj_timeline (etime-single-wait-all-for-submit-submitted)
[220.019780] Starting subtest: etime-single-wait-all-for-submit-submitted
[220.127941] Subtest etime-single-wait-all-for-submit-submitted: SUCCESS (0.108s)
[220.202479] [066/131] (798s left) gem_exec_whisper (basic-fds-forked)
[220.268638] Starting subtest: basic-fds-forked
[244.245712] Subtest basic-fds-forked: SUCCESS (23.973s)
[244.427803] [067/131] (773s left) drm_mm (drm_mm)
[244.466793] Starting subtest: drm_mm
[244.515869] Starting dynamic subtest: drm_test_mm_init
[244.651092] Dynamic subtest drm_test_mm_init: SUCCESS (0.134s)
[244.660789] Starting dynamic subtest: drm_test_mm_debug
[244.796918] Dynamic subtest drm_test_mm_debug: SUCCESS (0.144s)
[244.807181] Starting dynamic subtest: drm_test_mm_align32
[244.940219] Dynamic subtest drm_test_mm_align32: SUCCESS (0.144s)
[244.948617] Starting dynamic subtest: drm_test_mm_align64
[245.116032] Dynamic subtest drm_test_mm_align64: SUCCESS (0.175s)
[245.125776] Starting dynamic subtest: drm_test_mm_lowest
[245.253168] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.135s)
[245.261179] Starting dynamic subtest: drm_test_mm_highest
[245.371195] Dynamic subtest drm_test_mm_highest: SUCCESS (0.119s)
[245.373104] Subtest drm_mm: SUCCESS (0.902s)
[245.552921] [068/131] (772s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-render)
[245.660866] Starting subtest: psr-2p-primscrn-cur-indfb-draw-render
[245.665422] Subtest psr-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[245.747743] [069/131] (772s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc)
[245.838061] Starting subtest: fbcpsr-rgb565-draw-mmap-wc
[252.572692] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (6.735s)
[252.719164] [070/131] (765s left) kms_psr2_su (page_flip-p010)
[252.773162] Subtest page_flip-P010: SKIP (0.000s)
[252.828449] [071/131] (765s left) kms_frontbuffer_tracking (fbc-rgb565-draw-blt)
[252.921879] Starting subtest: fbc-rgb565-draw-blt
[257.243326] Subtest fbc-rgb565-draw-blt: SUCCESS (4.324s)
[258.417907] [072/131] (760s left) syncobj_timeline (single-wait-available-signaled)
[258.480660] Starting subtest: single-wait-available-signaled
[258.483089] Subtest single-wait-available-signaled: SUCCESS (0.000s)
[258.573177] [073/131] (759s left) perf (missing-sample-flags)
[258.701336] Starting subtest: missing-sample-flags
[258.703579] Subtest missing-sample-flags: SUCCESS (0.000s)
[258.747588] [074/131] (759s left) kms_rotation_crc (primary-y-tiled-reflect-x-270)
[258.844877] Starting subtest: primary-y-tiled-reflect-x-270
[258.849219] Subtest primary-y-tiled-reflect-x-270: SKIP (0.001s)
[258.916597] [075/131] (759s left) gem_lmem_swapping (random-engines)
[258.963718] Subtest random-engines: SKIP (0.000s)
[259.007662] [076/131] (759s left) i915_query (test-query-geometry-subslices)
[259.066874] Starting subtest: test-query-geometry-subslices
[259.069146] Subtest test-query-geometry-subslices: SUCCESS (0.000s)
[259.176914] [077/131] (759s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-wc)
[259.277821] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-wc
[259.281925] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s)
[259.384869] [078/131] (759s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs)
[259.474432] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs
[259.476428] Starting dynamic subtest: pipe-A-eDP-1
[275.999889] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s)
[276.009096] Starting dynamic subtest: pipe-B-eDP-1
[293.893893] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.754s)
[293.903194] Starting dynamic subtest: pipe-C-eDP-1
[311.874513] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.730s)
[311.884392] Starting dynamic subtest: pipe-D-eDP-1
[329.870923] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.643s)
[329.872883] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs: SUCCESS (10.065s)
[339.113303] [079/131] (687s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-mc-ccs)
[339.219598] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-mc-ccs
[339.222027] Starting dynamic subtest: pipe-A-eDP-1
[339.246433] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[339.258224] Starting dynamic subtest: pipe-B-eDP-1
[339.280793] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[339.289983] Starting dynamic subtest: pipe-C-eDP-1
[339.313591] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[339.323537] Starting dynamic subtest: pipe-D-eDP-1
[339.347098] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[339.352038] Subtest crc-primary-rotation-180-4-tiled-dg2-mc-ccs: SKIP (0.005s)
[341.437153] [080/131] (685s left) syncobj_wait (multi-wait-all-submitted)
[341.499356] Starting subtest: multi-wait-all-submitted
[341.608038] Subtest multi-wait-all-submitted: SUCCESS (0.105s)
[341.685551] [081/131] (685s left) kms_content_protection (legacy)
[341.836973] Starting subtest: legacy
[345.744364] Subtest legacy: SKIP (3.832s)
[346.958713] [082/131] (679s left) kms_atomic_transition (plane-use-after-nonblocking-unbind)
[347.057827] Starting subtest: plane-use-after-nonblocking-unbind
[347.060213] Starting dynamic subtest: pipe-A-eDP-1
[347.124682] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.068s)
[347.430710] Starting dynamic subtest: pipe-B-eDP-1
[348.281876] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.851s)
[348.569121] Subtest plane-use-after-nonblocking-unbind: SUCCESS (1.496s)
[349.447914] [083/131] (677s left) gem_create (create-ext-cpu-access-big)
[349.613916] Starting subtest: create-ext-cpu-access-big
[349.618689] Subtest create-ext-cpu-access-big: SKIP (0.001s)
[349.691526] [084/131] (677s left) gem_exec_balancer (busy)
[349.752805] Starting subtest: busy
[351.245403] Subtest busy: SUCCESS (1.479s)
[351.572686] [085/131] (675s left) kms_psr (fbc-psr2-sprite-render)
[351.662539] Starting subtest: fbc-psr2-sprite-render
[351.664746] Starting dynamic subtest: eDP-1
[351.668805] Dynamic subtest eDP-1: SKIP (0.000s)
[351.672952] Subtest fbc-psr2-sprite-render: SKIP (0.001s)
[351.738361] [086/131] (675s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-onoff)
[351.852296] Starting subtest: psr-2p-scndscrn-cur-indfb-onoff
[351.856294] Subtest psr-2p-scndscrn-cur-indfb-onoff: SKIP (0.000s)
[351.960541] [087/131] (675s left) kms_flip (flip-vs-expired-vblank)
[352.054840] Starting subtest: flip-vs-expired-vblank
[352.057027] Starting dynamic subtest: A-eDP1
[360.789748] Dynamic subtest A-eDP1: SUCCESS (8.701s)
[360.799081] Starting dynamic subtest: B-eDP1
[369.458068] Dynamic subtest B-eDP1: SUCCESS (8.653s)
[369.472981] Starting dynamic subtest: C-eDP1
[378.084203] Dynamic subtest C-eDP1: SUCCESS (8.623s)
[378.093751] Starting dynamic subtest: D-eDP1
[386.713342] Dynamic subtest D-eDP1: SUCCESS (8.626s)
[386.715901] Subtest flip-vs-expired-vblank: SUCCESS (34.612s)
[387.886083] [088/131] (639s left) gem_userptr_blits (readonly-pwrite-unsync)
[387.944045] Subtest readonly-pwrite-unsync: SKIP (0.000s)
[388.070377] [089/131] (639s left) gem_pwrite (basic-self)
[388.133378] Subtest basic-self: SKIP (0.000s)
[388.201200] [090/131] (639s left) kms_lease (lease-again)
[388.301567] Starting subtest: lease-again
[388.303879] Starting dynamic subtest: pipe-A-eDP-1
[388.306099] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.002s)
[388.315876] Starting dynamic subtest: pipe-B-eDP-1
[388.317781] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.004s)
[388.327060] Starting dynamic subtest: pipe-C-eDP-1
[388.328903] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.002s)
[388.337328] Starting dynamic subtest: pipe-D-eDP-1
[388.339154] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.002s)
[388.341052] Subtest lease-again: SUCCESS (0.015s)
[388.433541] [091/131] (638s left) syncobj_wait (invalid-wait-bad-flags)
[388.496380] Starting subtest: invalid-wait-bad-flags
[388.498854] Subtest invalid-wait-bad-flags: SUCCESS (0.000s)
[388.605509] [092/131] (638s left) gem_exec_params (invalid-bsd2-flag-on-render)
[388.668235] Starting subtest: invalid-bsd2-flag-on-render
[388.670847] Subtest invalid-bsd2-flag-on-render: SUCCESS (0.000s)
[388.767695] [093/131] (638s left) gem_partial_pwrite_pread (write-snoop)
[388.831194] Subtest write-snoop: SKIP (0.000s)
[388.897337] [094/131] (638s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[388.991600] Starting subtest: nonblocking-crc-frame-sequence
[388.993128] Starting dynamic subtest: pipe-A-eDP-1
[389.701271] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.709s)
[389.711848] Starting dynamic subtest: pipe-B-eDP-1
[391.096829] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.393s)
[391.109822] Starting dynamic subtest: pipe-C-eDP-1
[392.478089] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s)
[392.488972] Starting dynamic subtest: pipe-D-eDP-1
[393.794173] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.313s)
[393.796523] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.801s)
[394.624035] [095/131] (632s left) kms_pm_dc (dc5-retention-flops)
[395.726539] Starting subtest: dc5-retention-flops
[395.731021] Subtest dc5-retention-flops: SKIP (0.000s)
[395.797833] [096/131] (631s left) kms_chamelium_frames (dp-crc-multiple)
[396.171180] Subtest dp-crc-multiple: SKIP (0.000s)
[397.029197] [097/131] (630s left) kms_flip (flip-vs-rmfb)
[397.118242] Starting subtest: flip-vs-rmfb
[397.120564] Starting dynamic subtest: A-eDP1
[405.764995] Dynamic subtest A-eDP1: SUCCESS (8.642s)
[405.776215] Starting dynamic subtest: B-eDP1
[414.408598] Dynamic subtest B-eDP1: SUCCESS (8.639s)
[414.420431] Starting dynamic subtest: C-eDP1
[423.035513] Dynamic subtest C-eDP1: SUCCESS (8.621s)
[423.046485] Starting dynamic subtest: D-eDP1
[431.668315] Dynamic subtest D-eDP1: SUCCESS (8.628s)
[431.672873] Subtest flip-vs-rmfb: SUCCESS (34.539s)
[432.853628] [098/131] (594s left) kms_panel_fitting (legacy)
[432.956969] Starting subtest: legacy
[432.958997] Starting dynamic subtest: pipe-A-eDP-1
[433.511811] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.557s)
[433.539253] Starting dynamic subtest: pipe-B-eDP-1
[435.102317] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.571s)
[435.130964] Starting dynamic subtest: pipe-C-eDP-1
[436.606708] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.484s)
[436.633323] Starting dynamic subtest: pipe-D-eDP-1
[438.131295] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.504s)
[438.133626] Subtest legacy: SUCCESS (5.179s)
[439.377401] [099/131] (588s left) kms_color (legacy-gamma)
[439.485867] Starting subtest: legacy-gamma
[439.488059] Starting dynamic subtest: pipe-A-eDP-1
[440.167418] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.684s)
[440.177536] Starting dynamic subtest: pipe-B-eDP-1
[441.543526] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.374s)
[441.555399] Starting dynamic subtest: pipe-C-eDP-1
[442.830916] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.289s)
[442.840897] Starting dynamic subtest: pipe-D-eDP-1
[444.171038] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.340s)
[444.173223] Subtest legacy-gamma: SUCCESS (4.689s)
[445.003396] [100/131] (582s left) kms_invalid_mode (bad-hsync-end)
[445.104775] Starting subtest: bad-hsync-end
[445.107065] Starting dynamic subtest: pipe-A-eDP-1
[445.389623] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.285s)
[445.400602] Starting dynamic subtest: pipe-B-eDP-1
[445.402500] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.000s)
[445.411523] Starting dynamic subtest: pipe-C-eDP-1
[445.413621] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.000s)
[445.422297] Starting dynamic subtest: pipe-D-eDP-1
[445.424552] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.000s)
[445.426860] Subtest bad-hsync-end: SUCCESS (0.291s)
[446.228979] [101/131] (581s left) kms_scaling_modes (scaling-mode-center)
[446.323485] Starting subtest: scaling-mode-center
[446.325852] Starting dynamic subtest: pipe-A-eDP-1
[446.415878] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.095s)
[446.425282] Starting dynamic subtest: pipe-B-eDP-1
[447.547518] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.130s)
[447.562972] Starting dynamic subtest: pipe-C-eDP-1
[448.655301] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.105s)
[448.665006] Starting dynamic subtest: pipe-D-eDP-1
[449.783738] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.127s)
[449.786124] Subtest scaling-mode-center: SUCCESS (3.465s)
[450.953883] [102/131] (576s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions)
[451.074277] Starting subtest: cursorB-vs-flipA-atomic-transitions
[451.078967] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.001s)
[451.227341] [103/131] (576s left) kms_ccs (missing-ccs-buffer-y-tiled-ccs)
[451.323490] Starting subtest: missing-ccs-buffer-y-tiled-ccs
[451.325589] Starting dynamic subtest: pipe-A-eDP-1
[451.347823] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[451.357648] Starting dynamic subtest: pipe-B-eDP-1
[451.379580] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[451.388223] Starting dynamic subtest: pipe-C-eDP-1
[451.409793] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[451.418399] Starting dynamic subtest: pipe-D-eDP-1
[451.440586] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[451.445251] Subtest missing-ccs-buffer-y-tiled-ccs: SKIP (0.004s)
[453.542777] [104/131] (574s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-draw-blt)
[453.637513] Starting subtest: fbc-2p-primscrn-spr-indfb-draw-blt
[453.641735] Subtest fbc-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s)
[453.753001] [105/131] (574s left) gem_exec_schedule (preempt-queue-contexts)
[453.831170] Subtest preempt-queue-contexts: SKIP (0.000s)
[454.113002] [106/131] (573s left) kms_getfb (getfb2-handle-protection)
[454.194305] Starting subtest: getfb2-handle-protection
[454.221671] Subtest getfb2-handle-protection: SUCCESS (0.028s)
[454.367090] [107/131] (573s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu)
[454.466024] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu
[454.470235] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s)
[454.574974] [108/131] (573s left) gem_exec_reloc (basic-wc-read)
[454.624886] Subtest basic-wc-read: SKIP (0.000s)
[454.688493] [109/131] (573s left) kms_psr2_sf (pr-primary-plane-update-sf-dmg-area-big-fb)
[459.704312] Starting subtest: pr-primary-plane-update-sf-dmg-area-big-fb
[459.709211] Subtest pr-primary-plane-update-sf-dmg-area-big-fb: SKIP (0.002s)
[460.553901] [110/131] (567s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[460.652706] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[460.655021] Starting dynamic subtest: A-eDP1
[469.602168] Dynamic subtest A-eDP1: SUCCESS (8.949s)
[469.611646] Starting dynamic subtest: B-eDP1
[478.529771] Dynamic subtest B-eDP1: SUCCESS (8.924s)
[478.541228] Starting dynamic subtest: C-eDP1
[487.451769] Dynamic subtest C-eDP1: SUCCESS (8.918s)
[487.463200] Starting dynamic subtest: D-eDP1
[496.384496] Dynamic subtest D-eDP1: SUCCESS (8.930s)
[496.388909] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.733s)
[497.619032] [111/131] (530s left) i915_pm_rc6_residency (media-rc6-accuracy)
[497.680002] Starting subtest: media-rc6-accuracy
[497.684491] Subtest media-rc6-accuracy: SKIP (0.000s)
[497.777355] [112/131] (530s left) kms_plane_scaling (plane-upscale-factor-0-25-with-modifiers)
[497.870240] Starting subtest: plane-upscale-factor-0-25-with-modifiers
[497.872621] Starting dynamic subtest: pipe-A
[498.205300] Dynamic subtest pipe-A: SUCCESS (0.338s)
[498.214257] Starting dynamic subtest: pipe-B
[499.611256] Dynamic subtest pipe-B: SUCCESS (1.405s)
[499.623129] Starting dynamic subtest: pipe-C
[501.040515] Dynamic subtest pipe-C: SUCCESS (1.428s)
[501.049623] Starting dynamic subtest: pipe-D
[502.474643] Dynamic subtest pipe-D: SUCCESS (1.432s)
[502.476970] Subtest plane-upscale-factor-0-25-with-modifiers: SUCCESS (4.606s)
[503.657634] [113/131] (524s left) gem_userptr_blits (unsync-unmap-after-close)
[503.726202] Subtest unsync-unmap-after-close: SKIP (0.000s)
[503.880494] [114/131] (524s left) gen9_exec_parse (unaligned-access)
[503.933911] Subtest unaligned-access: SKIP (0.000s)
[504.020097] [115/131] (524s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip)
[504.113145] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip
[504.893301] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SUCCESS (0.781s)
[505.087375] [116/131] (523s left) kms_async_flips (crc)
[505.183233] Starting subtest: crc
[505.556255] Starting dynamic subtest: pipe-A-eDP-1
[508.456968] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.901s)
[508.837579] Starting dynamic subtest: pipe-B-eDP-1
[511.703172] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.874s)
[512.082162] Starting dynamic subtest: pipe-C-eDP-1
[514.913799] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.843s)
[515.275313] Starting dynamic subtest: pipe-D-eDP-1
[518.147290] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.879s)
[518.149578] Subtest crc: SUCCESS (12.961s)
[519.328880] [117/131] (509s left) perf (enable-disable)
[519.415696] Starting subtest: enable-disable
[519.418091] Starting dynamic subtest: 0-rcs0
[521.685743] Dynamic subtest 0-rcs0: SUCCESS (2.268s)
[521.695803] Starting dynamic subtest: 1-vecs0
[526.176977] Dynamic subtest 1-vecs0: SUCCESS (4.489s)
[526.179486] Subtest enable-disable: SUCCESS (6.758s)
[526.225224] [118/131] (502s left) perf (non-system-wide-paranoid)
[526.300197] Starting subtest: non-system-wide-paranoid
[526.325383] Subtest non-system-wide-paranoid: SUCCESS (0.025s)
[526.375181] [119/131] (502s left) kms_sequence (get-idle)
[526.473479] Starting subtest: get-idle
[526.475402] Starting dynamic subtest: pipe-A-eDP-1
[528.290104] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.816s)
[528.302508] Starting dynamic subtest: pipe-B-eDP-1
[530.803661] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.512s)
[530.813748] Starting dynamic subtest: pipe-C-eDP-1
[533.218786] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.412s)
[533.232763] Starting dynamic subtest: pipe-D-eDP-1
[535.656797] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.438s)
[535.659225] Subtest get-idle: SUCCESS (9.183s)
[536.461771] [120/131] (492s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary)
[536.570481] Starting subtest: fbc-indfb-scaledprimary
[541.670754] Subtest fbc-indfb-scaledprimary: SUCCESS (5.100s)
[542.866660] [121/131] (485s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[542.960675] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[542.964560] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[543.072688] [122/131] (485s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-fullscreen)
[543.162034] Starting subtest: fbc-2p-primscrn-spr-indfb-fullscreen
[543.166235] Subtest fbc-2p-primscrn-spr-indfb-fullscreen: SKIP (0.000s)
[543.264260] [123/131] (485s left) kms_pm_rpm (pm-tiling)
[545.387878] Starting subtest: pm-tiling
[545.393107] Subtest pm-tiling: SKIP (0.000s)
[545.760771] [124/131] (482s left) gem_exec_params (invalid-flag)
[545.819709] Starting subtest: invalid-flag
[545.822090] Subtest invalid-flag: SUCCESS (0.000s)
[545.938684] [125/131] (482s left) gem_exec_create (forked)
[545.993461] Starting subtest: forked
[545.995923] Starting dynamic subtest: smem
[566.177258] Dynamic subtest smem: SUCCESS (20.179s)
[566.179602] Subtest forked: SUCCESS (20.180s)
[566.360380] [126/131] (462s left) gem_softpin (allocator-basic-reserve)
[566.430240] Starting subtest: allocator-basic-reserve
[566.511004] Subtest allocator-basic-reserve: SUCCESS (0.080s)
[566.644232] [127/131] (462s left) gem_exec_balancer (invalid-bonds)
[566.701289] Starting subtest: invalid-bonds
[566.705407] Subtest invalid-bonds: SKIP (0.000s)
[567.018578] [128/131] (461s left) gem_exec_schedule (pi-common)
[567.198449] Starting subtest: pi-common
[567.200839] Starting dynamic subtest: rcs0
[567.282920] Dynamic subtest rcs0: SUCCESS (0.088s)
[567.295061] Starting dynamic subtest: bcs0
[567.372989] Dynamic subtest bcs0: SUCCESS (0.089s)
[567.385185] Starting dynamic subtest: vcs0
[567.455454] Dynamic subtest vcs0: SUCCESS (0.081s)
[567.471713] Starting dynamic subtest: vcs1
[567.538156] Dynamic subtest vcs1: SUCCESS (0.082s)
[567.555699] Starting dynamic subtest: vecs0
[567.619209] Dynamic subtest vecs0: SUCCESS (0.080s)
[567.636507] Starting dynamic subtest: ccs0
[567.700065] Dynamic subtest ccs0: SUCCESS (0.080s)
[567.703029] Subtest pi-common: SUCCESS (0.507s)
[567.978222] [129/131] (460s left) gem_exec_reloc (basic-cpu-read)
[568.040505] Subtest basic-cpu-read: SKIP (0.000s)
[568.124609] [130/131] (460s left) i915_drm_fdinfo (virtual-busy-idle)
[568.170158] Starting subtest: virtual-busy-idle
[568.174921] Subtest virtual-busy-idle: SKIP (0.000s)
[568.233216] [131/131] (460s left) kms_psr (pr-sprite-render)
[568.332513] Starting subtest: pr-sprite-render
[568.336866] Subtest pr-sprite-render: SKIP (0.000s)
[568.400102] Closing watchdogs
results: parsing output: 0/ for test: perf_pmu
results: parsing output: 1/ for test: syncobj_wait
results: parsing output: 2/ for test: gem_wait
results: parsing output: 3/ for test: kms_plane_lowres
results: parsing output: 4/ for test: kms_frontbuffer_tracking
results: parsing output: 5/ for test: gem_exec_fence
results: parsing output: 6/ for test: syncobj_timeline
results: parsing output: 7/ for test: gem_ctx_param
results: parsing output: 8/ for test: syncobj_wait
results: parsing output: 9/ for test: kms_dsc
results: parsing output: 10/ for test: gem_render_copy
results: parsing output: 11/ for test: gem_exec_schedule
results: parsing output: 12/ for test: kms_psr
results: parsing output: 13/ for test: api_intel_bb
results: parsing output: 14/ for test: gem_create
results: parsing output: 15/ for test: kms_big_fb
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: kms_big_fb
results: parsing output: 18/ for test: kms_atomic
results: parsing output: 19/ for test: gem_mmap_offset
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_frontbuffer_tracking
results: parsing output: 22/ for test: gem_exec_params
results: parsing output: 23/ for test: api_intel_bb
results: parsing output: 24/ for test: gem_userptr_blits
results: parsing output: 25/ for test: syncobj_timeline
results: parsing output: 26/ for test: gem_ctx_shared
results: parsing output: 27/ for test: kms_frontbuffer_tracking
results: parsing output: 28/ for test: gem_userptr_blits
results: parsing output: 29/ for test: gem_mmap_gtt
results: parsing output: 30/ for test: sw_sync
results: parsing output: 31/ for test: gem_mmap_wc
results: parsing output: 32/ for test: kms_cursor_edge_walk
results: parsing output: 33/ for test: prime_vgem
results: parsing output: 34/ for test: gem_tiled_wc
results: parsing output: 35/ for test: kms_frontbuffer_tracking
results: parsing output: 36/ for test: gem_exec_fence
results: parsing output: 37/ for test: kms_flip_scaled_crc
results: parsing output: 38/ for test: gem_mmap_gtt
results: parsing output: 39/ for test: kms_plane_scaling
results: parsing output: 40/ for test: kms_chamelium_hpd
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: sw_sync
results: parsing output: 43/ for test: kms_frontbuffer_tracking
results: parsing output: 44/ for test: kms_cursor_crc
results: parsing output: 45/ for test: kms_big_fb
results: parsing output: 46/ for test: kms_ccs
results: parsing output: 47/ for test: i915_pm_sseu
results: parsing output: 48/ for test: kms_addfb_basic
results: parsing output: 49/ for test: sysfs_defaults
results: parsing output: 50/ for test: kms_big_fb
results: parsing output: 51/ for test: kms_feature_discovery
results: parsing output: 52/ for test: kms_frontbuffer_tracking
results: parsing output: 53/ for test: gem_ctx_bad_destroy
results: parsing output: 54/ for test: gem_linear_blits
results: parsing output: 55/ for test: gem_exec_reloc
results: parsing output: 56/ for test: kms_psr2_sf
results: parsing output: 57/ for test: kms_writeback
results: parsing output: 58/ for test: kms_big_fb
results: parsing output: 59/ for test: gem_ctx_param
results: parsing output: 60/ for test: kms_psr
results: parsing output: 61/ for test: syncobj_timeline
results: parsing output: 62/ for test: kms_flip
results: parsing output: 63/ for test: gem_spin_batch
results: parsing output: 64/ for test: syncobj_timeline
results: parsing output: 65/ for test: gem_exec_whisper
results: parsing output: 66/ for test: drm_mm
results: parsing output: 67/ for test: kms_frontbuffer_tracking
results: parsing output: 68/ for test: kms_frontbuffer_tracking
results: parsing output: 69/ for test: kms_psr2_su
results: parsing output: 70/ for test: kms_frontbuffer_tracking
results: parsing output: 71/ for test: syncobj_timeline
results: parsing output: 72/ for test: perf
results: parsing output: 73/ for test: kms_rotation_crc
results: parsing output: 74/ for test: gem_lmem_swapping
results: parsing output: 75/ for test: i915_query
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_ccs
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: syncobj_wait
results: parsing output: 80/ for test: kms_content_protection
results: parsing output: 81/ for test: kms_atomic_transition
results: parsing output: 82/ for test: gem_create
results: parsing output: 83/ for test: gem_exec_balancer
results: parsing output: 84/ for test: kms_psr
results: parsing output: 85/ for test: kms_frontbuffer_tracking
results: parsing output: 86/ for test: kms_flip
results: parsing output: 87/ for test: gem_userptr_blits
results: parsing output: 88/ for test: gem_pwrite
results: parsing output: 89/ for test: kms_lease
results: parsing output: 90/ for test: syncobj_wait
results: parsing output: 91/ for test: gem_exec_params
results: parsing output: 92/ for test: gem_partial_pwrite_pread
results: parsing output: 93/ for test: kms_pipe_crc_basic
results: parsing output: 94/ for test: kms_pm_dc
results: parsing output: 95/ for test: kms_chamelium_frames
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_panel_fitting
results: parsing output: 98/ for test: kms_color
results: parsing output: 99/ for test: kms_invalid_mode
results: parsing output: 100/ for test: kms_scaling_modes
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_ccs
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: kms_getfb
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: gem_exec_reloc
results: parsing output: 108/ for test: kms_psr2_sf
results: parsing output: 109/ for test: kms_flip
results: parsing output: 110/ for test: i915_pm_rc6_residency
results: parsing output: 111/ for test: kms_plane_scaling
results: parsing output: 112/ for test: gem_userptr_blits
results: parsing output: 113/ for test: gen9_exec_parse
results: parsing output: 114/ for test: kms_big_fb
results: parsing output: 115/ for test: kms_async_flips
results: parsing output: 116/ for test: perf
results: parsing output: 117/ for test: perf
results: parsing output: 118/ for test: kms_sequence
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_frontbuffer_tracking
results: parsing output: 121/ for test: kms_frontbuffer_tracking
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: gem_exec_params
results: parsing output: 124/ for test: gem_exec_create
results: parsing output: 125/ for test: gem_softpin
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: gem_exec_schedule
results: parsing output: 128/ for test: gem_exec_reloc
results: parsing output: 129/ for test: i915_drm_fdinfo
results: parsing output: 130/ for test: kms_psr
Done.