[41.367548] Initializing watchdogs [41.367743] /dev/watchdog0 [41.422355] [001/164] (960s left) i915_module_load (load) [41.664526] Starting subtest: load [44.135200] Subtest load: SUCCESS (2.464s) [44.260308] [002/164] (957s left) core_auth (basic-auth) [44.554299] Starting subtest: basic-auth [44.575547] Subtest basic-auth: SUCCESS (0.002s) [44.661983] [003/164] (957s left) debugfs_test (read_all_entries) [44.905206] Starting subtest: read_all_entries [45.284153] Subtest read_all_entries: SUCCESS (0.395s) [45.508872] [004/164] (956s left) debugfs_test (basic-hwmon) [45.780962] Starting subtest: basic-hwmon [45.836968] Subtest basic-hwmon: SKIP (0.000s) [45.983573] [005/164] (956s left) fbdev (eof) [46.225132] Starting subtest: eof [46.245322] Subtest eof: SUCCESS (0.002s) [46.352954] [006/164] (956s left) fbdev (info) [46.580790] Starting subtest: info [46.601406] Subtest info: SUCCESS (0.000s) [46.732404] [007/164] (955s left) fbdev (nullptr) [46.943208] Starting subtest: nullptr [46.965224] Subtest nullptr: SUCCESS (0.000s) [47.076091] [008/164] (955s left) fbdev (read) [47.290342] Starting subtest: read [48.758165] Subtest read: SUCCESS (1.476s) [48.867388] [009/164] (953s left) fbdev (write) [49.078282] Starting subtest: write [49.827348] Subtest write: SUCCESS (0.765s) [49.936654] [010/164] (952s left) gem_basic (bad-close) [50.173563] Starting subtest: bad-close [50.214388] Subtest bad-close: SUCCESS (0.000s) [50.304320] [011/164] (952s left) gem_basic (create-close) [50.534719] Starting subtest: create-close [50.577515] Subtest create-close: SUCCESS (0.000s) [50.667063] [012/164] (952s left) gem_basic (create-fd-close) [50.898516] Starting subtest: create-fd-close [50.942437] Subtest create-fd-close: SUCCESS (0.000s) [51.028814] [013/164] (951s left) gem_busy (busy@all-engines) [51.270138] Starting subtest: busy [51.289373] Starting dynamic subtest: all-engines [51.355566] Dynamic subtest all-engines: SUCCESS (0.095s) [51.376211] Subtest busy: SUCCESS (0.095s) [51.775337] [014/164] (951s left) gem_close_race (basic-process) [52.039804] Starting subtest: basic-process [52.121369] Subtest basic-process: SUCCESS (0.102s) [52.345067] [015/164] (950s left) gem_close_race (basic-threads) [52.580964] Starting subtest: basic-threads [53.801119] Subtest basic-threads: SUCCESS (1.222s) [54.028288] [016/164] (949s left) gem_ctx_create (basic) [54.272321] Starting subtest: basic [54.292704] Subtest basic: SUCCESS (0.000s) [54.484746] [017/164] (948s left) gem_ctx_create (basic-files) [54.698248] Starting subtest: basic-files [56.754629] Subtest basic-files: SUCCESS (2.039s) [56.998449] [018/164] (946s left) gem_ctx_exec (basic) [57.244594] Starting subtest: basic [57.264840] Subtest basic: SUCCESS (0.009s) [57.359396] [019/164] (946s left) gem_exec_basic (basic) [57.600478] Starting subtest: basic [57.622712] Starting dynamic subtest: rcs0-smem [57.642707] Dynamic subtest rcs0-smem: SUCCESS (0.003s) [57.675512] Starting dynamic subtest: bcs0-smem [57.697564] Dynamic subtest bcs0-smem: SUCCESS (0.002s) [57.733665] Starting dynamic subtest: vcs0-smem [57.753707] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [57.788111] Starting dynamic subtest: vecs0-smem [57.811045] Dynamic subtest vecs0-smem: SUCCESS (0.002s) [57.833071] Subtest basic: SUCCESS (0.010s) [57.920456] [020/164] (945s left) gem_exec_create (basic) [58.149624] Starting subtest: basic [58.169951] Starting dynamic subtest: smem [60.218730] Dynamic subtest smem: SUCCESS (2.071s) [60.242295] Subtest basic: SUCCESS (2.071s) [60.432250] [021/164] (943s left) gem_exec_fence (basic-busy) [60.800988] Starting subtest: basic-busy [60.820860] Starting dynamic subtest: rcs0 [60.865681] Dynamic subtest rcs0: SUCCESS (0.033s) [60.899525] Starting dynamic subtest: bcs0 [60.941887] Dynamic subtest bcs0: SUCCESS (0.026s) [60.976591] Starting dynamic subtest: vcs0 [61.017283] Dynamic subtest vcs0: SUCCESS (0.031s) [61.054902] Starting dynamic subtest: vecs0 [61.098562] Dynamic subtest vecs0: SUCCESS (0.028s) [61.120380] Subtest basic-busy: SUCCESS (0.120s) [61.726153] [022/164] (942s left) gem_exec_fence (basic-wait) [62.078904] Starting subtest: basic-wait [62.099055] Starting dynamic subtest: rcs0 [62.118989] Dynamic subtest rcs0: SUCCESS (0.031s) [62.156900] Starting dynamic subtest: bcs0 [62.179661] Dynamic subtest bcs0: SUCCESS (0.026s) [62.213788] Starting dynamic subtest: vcs0 [62.233911] Dynamic subtest vcs0: SUCCESS (0.031s) [62.270681] Starting dynamic subtest: vecs0 [62.293971] Dynamic subtest vecs0: SUCCESS (0.022s) [62.314389] Subtest basic-wait: SUCCESS (0.112s) [62.893469] [023/164] (940s left) gem_exec_fence (basic-await) [63.256962] Starting subtest: basic-await [63.276985] Starting dynamic subtest: rcs0 [63.390525] Dynamic subtest rcs0: SUCCESS (0.139s) [63.429239] Starting dynamic subtest: bcs0 [63.521591] Dynamic subtest bcs0: SUCCESS (0.132s) [63.563884] Starting dynamic subtest: vcs0 [63.660630] Dynamic subtest vcs0: SUCCESS (0.135s) [63.698346] Starting dynamic subtest: vecs0 [63.796295] Dynamic subtest vecs0: SUCCESS (0.136s) [63.816390] Subtest basic-await: SUCCESS (0.546s) [64.497247] [024/164] (939s left) gem_exec_fence (nb-await) [64.858226] Starting subtest: nb-await [64.878261] Starting dynamic subtest: rcs0 [64.939519] Dynamic subtest rcs0: SUCCESS (0.079s) [64.974682] Starting dynamic subtest: bcs0 [65.017691] Dynamic subtest bcs0: SUCCESS (0.072s) [65.055856] Starting dynamic subtest: vcs0 [65.096738] Dynamic subtest vcs0: SUCCESS (0.071s) [65.134846] Starting dynamic subtest: vecs0 [65.156912] Dynamic subtest vecs0: SUCCESS (0.071s) [65.177681] Subtest nb-await: SUCCESS (0.294s) [65.863900] [025/164] (938s left) gem_exec_gttfill (basic) [66.102969] Starting subtest: basic [88.152651] Subtest basic: SUCCESS (21.885s) [88.249924] [026/164] (915s left) gem_exec_parallel (engines) [88.659629] Starting subtest: engines [88.681585] Starting dynamic subtest: basic [92.505488] Dynamic subtest basic: SUCCESS (3.675s) [92.546907] Starting dynamic subtest: contexts [97.188673] Dynamic subtest contexts: SUCCESS (4.697s) [97.226790] Starting dynamic subtest: fds [103.942066] Dynamic subtest fds: SUCCESS (6.749s) [103.981200] Starting dynamic subtest: userptr [107.629468] Dynamic subtest userptr: SUCCESS (3.673s) [107.650083] Subtest engines: SUCCESS (18.796s) [107.759247] [027/164] (896s left) gem_exec_store (basic) [108.066366] Starting subtest: basic [108.087139] Subtest basic: SUCCESS (0.066s) [108.282419] [028/164] (895s left) gem_flink_basic (bad-flink) [108.515097] Starting subtest: bad-flink [108.535894] Subtest bad-flink: SUCCESS (0.000s) [108.629322] [029/164] (895s left) gem_flink_basic (bad-open) [108.862967] Starting subtest: bad-open [108.885055] Subtest bad-open: SUCCESS (0.000s) [108.976435] [030/164] (895s left) gem_flink_basic (basic) [109.207334] Starting subtest: basic [109.228133] Subtest basic: SUCCESS (0.000s) [109.321630] [031/164] (895s left) gem_flink_basic (double-flink) [109.552154] Starting subtest: double-flink [109.574621] Subtest double-flink: SUCCESS (0.000s) [109.665691] [032/164] (894s left) gem_flink_basic (flink-lifetime) [109.895853] Starting subtest: flink-lifetime [109.918606] Subtest flink-lifetime: SUCCESS (0.003s) [110.011228] [033/164] (894s left) gem_huc_copy (huc-copy) [110.245983] Starting subtest: huc-copy [110.269754] Subtest huc-copy: SUCCESS (0.005s) [110.364952] [034/164] (894s left) gem_linear_blits (basic) [110.761987] Starting subtest: basic [110.786265] Subtest basic: SUCCESS (0.020s) [111.012425] [035/164] (893s left) gem_mmap (basic) [111.427276] Starting subtest: basic [111.534705] Subtest basic: SUCCESS (0.001s) [111.624053] [036/164] (893s left) gem_mmap_gtt (basic) [111.846080] Starting subtest: basic [111.868351] Subtest basic: SUCCESS (0.001s) [111.959404] [037/164] (893s left) gem_render_linear_blits (basic) [112.193231] Starting subtest: basic [112.297150] Subtest basic: SUCCESS (0.092s) [112.389935] [038/164] (892s left) gem_render_tiled_blits (basic) [112.631251] Starting subtest: basic [112.757158] Subtest basic: SUCCESS (0.119s) [112.848588] [039/164] (892s left) gem_ringfill (basic-all) [113.373897] Starting subtest: basic-all [114.550345] Subtest basic-all: SUCCESS (1.213s) [114.700360] [040/164] (890s left) gem_softpin (allocator-basic) [114.941207] Starting subtest: allocator-basic [115.156900] Subtest allocator-basic: SUCCESS (0.243s) [115.295642] [041/164] (890s left) gem_softpin (allocator-basic-reserve) [115.527996] Starting subtest: allocator-basic-reserve [115.739831] Subtest allocator-basic-reserve: SUCCESS (0.239s) [115.876993] [042/164] (889s left) gem_softpin (safe-alignment) [116.112558] Starting subtest: safe-alignment [116.132841] Subtest safe-alignment: SUCCESS (0.031s) [116.253126] [043/164] (889s left) gem_sync (basic-all) [116.661774] Starting subtest: basic-all [118.559092] Subtest basic-all: SUCCESS (2.055s) [118.780443] [044/164] (886s left) gem_sync (basic-each) [119.166768] Starting subtest: basic-each [121.381930] Subtest basic-each: SUCCESS (2.381s) [121.600987] [045/164] (884s left) gem_tiled_blits (basic) [121.988670] Starting subtest: basic [122.035888] Subtest basic: SUCCESS (0.049s) [122.226363] [046/164] (883s left) gem_tiled_fence_blits (basic) [122.791969] Starting subtest: basic [122.837960] Subtest basic: SUCCESS (0.043s) [123.025968] [047/164] (882s left) gem_tiled_pread_basic [123.783472] [048/164] (882s left) gem_wait (busy@all-engines) [124.044109] Starting subtest: busy [124.066495] Starting dynamic subtest: all-engines [124.565759] Dynamic subtest all-engines: SUCCESS (0.526s) [124.588206] Subtest busy: SUCCESS (0.527s) [124.830641] [049/164] (881s left) gem_wait (wait@all-engines) [125.078804] Starting subtest: wait [125.100899] Starting dynamic subtest: all-engines [126.119216] Dynamic subtest all-engines: SUCCESS (1.047s) [126.147293] Subtest wait: SUCCESS (1.048s) [126.386438] [050/164] (879s left) i915_getparams_basic (basic-eu-total) [126.617957] Starting subtest: basic-eu-total [126.661072] Subtest basic-eu-total: SUCCESS (0.000s) [126.752457] [051/164] (879s left) i915_getparams_basic (basic-subslice-total) [126.992309] Starting subtest: basic-subslice-total [127.043261] Subtest basic-subslice-total: SUCCESS (0.000s) [127.145651] [052/164] (879s left) i915_hangman (error-state-basic) [127.389929] Starting subtest: error-state-basic [127.685857] Subtest error-state-basic: SUCCESS (0.290s) [127.780361] [053/164] (878s left) i915_pciid [128.125425] [054/164] (878s left) kms_addfb_basic (addfb25-4-tiled) [128.507581] Starting subtest: addfb25-4-tiled [128.528138] Subtest addfb25-4-tiled: SUCCESS (0.001s) [128.633518] [055/164] (878s left) kms_addfb_basic (addfb25-bad-modifier) [128.863235] Starting subtest: addfb25-bad-modifier [128.884240] Subtest addfb25-bad-modifier: SUCCESS (0.001s) [129.065545] [056/164] (877s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [129.299608] Starting subtest: addfb25-framebuffer-vs-set-tiling [129.321319] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [129.496957] [057/164] (877s left) kms_addfb_basic (addfb25-modifier-no-flag) [129.729296] Starting subtest: addfb25-modifier-no-flag [129.750908] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [129.930161] [058/164] (876s left) kms_addfb_basic (addfb25-x-tiled-legacy) [130.161523] Starting subtest: addfb25-x-tiled-legacy [130.181290] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [130.365971] [059/164] (876s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [130.603234] Starting subtest: addfb25-x-tiled-mismatch-legacy [130.624904] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s) [130.799968] [060/164] (876s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [131.121054] Starting subtest: addfb25-yf-tiled-legacy [131.143428] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [131.236419] [061/164] (875s left) kms_addfb_basic (addfb25-y-tiled-legacy) [131.554394] Starting subtest: addfb25-y-tiled-legacy [131.574501] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [131.669134] [062/164] (875s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [131.990047] Starting subtest: addfb25-y-tiled-small-legacy [132.012279] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s) [132.103100] [063/164] (875s left) kms_addfb_basic (bad-pitch-0) [132.336537] Starting subtest: bad-pitch-0 [132.356186] Subtest bad-pitch-0: SUCCESS (0.000s) [132.531830] [064/164] (874s left) kms_addfb_basic (bad-pitch-1024) [132.763753] Starting subtest: bad-pitch-1024 [132.785091] Subtest bad-pitch-1024: SUCCESS (0.000s) [132.966559] [065/164] (874s left) kms_addfb_basic (bad-pitch-128) [133.202257] Starting subtest: bad-pitch-128 [133.224118] Subtest bad-pitch-128: SUCCESS (0.000s) [133.395910] [066/164] (874s left) kms_addfb_basic (bad-pitch-256) [133.631524] Starting subtest: bad-pitch-256 [133.652418] Subtest bad-pitch-256: SUCCESS (0.000s) [133.840880] [067/164] (873s left) kms_addfb_basic (bad-pitch-32) [134.071631] Starting subtest: bad-pitch-32 [134.092857] Subtest bad-pitch-32: SUCCESS (0.000s) [134.264674] [068/164] (873s left) kms_addfb_basic (bad-pitch-63) [134.505877] Starting subtest: bad-pitch-63 [134.528100] Subtest bad-pitch-63: SUCCESS (0.000s) [134.682224] [069/164] (873s left) kms_addfb_basic (bad-pitch-65536) [134.914235] Starting subtest: bad-pitch-65536 [134.936204] Subtest bad-pitch-65536: SUCCESS (0.001s) [135.112389] [070/164] (872s left) kms_addfb_basic (bad-pitch-999) [135.326176] Starting subtest: bad-pitch-999 [135.347987] Subtest bad-pitch-999: SUCCESS (0.000s) [135.549624] [071/164] (872s left) kms_addfb_basic (basic) [135.790518] Starting subtest: basic [135.812327] Subtest basic: SUCCESS (0.000s) [135.984449] [072/164] (872s left) kms_addfb_basic (basic-x-tiled-legacy) [136.227607] Starting subtest: basic-x-tiled-legacy [136.249044] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [136.433677] [073/164] (871s left) kms_addfb_basic (basic-y-tiled-legacy) [136.678429] Starting subtest: basic-y-tiled-legacy [136.700404] Subtest basic-y-tiled-legacy: SUCCESS (0.001s) [136.868464] [074/164] (871s left) kms_addfb_basic (bo-too-small) [137.188346] Starting subtest: bo-too-small [137.211379] Subtest bo-too-small: SUCCESS (0.001s) [137.322149] [075/164] (871s left) kms_addfb_basic (bo-too-small-due-to-tiling) [137.640235] Starting subtest: bo-too-small-due-to-tiling [137.660764] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s) [137.762764] [076/164] (870s left) kms_addfb_basic (clobberred-modifier) [137.996367] Starting subtest: clobberred-modifier [138.017855] Subtest clobberred-modifier: SUCCESS (0.000s) [138.180387] [077/164] (870s left) kms_addfb_basic (framebuffer-vs-set-tiling) [138.412479] Starting subtest: framebuffer-vs-set-tiling [138.433122] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [138.614224] [078/164] (870s left) kms_addfb_basic (invalid-get-prop) [138.846635] Starting subtest: invalid-get-prop [138.866413] Subtest invalid-get-prop: SUCCESS (0.000s) [139.050164] [079/164] (869s left) kms_addfb_basic (invalid-get-prop-any) [139.279610] Starting subtest: invalid-get-prop-any [139.300940] Subtest invalid-get-prop-any: SUCCESS (0.000s) [139.482919] [080/164] (869s left) kms_addfb_basic (invalid-set-prop) [139.714183] Starting subtest: invalid-set-prop [139.735885] Subtest invalid-set-prop: SUCCESS (0.000s) [139.930990] [081/164] (869s left) kms_addfb_basic (invalid-set-prop-any) [140.166574] Starting subtest: invalid-set-prop-any [140.187661] Subtest invalid-set-prop-any: SUCCESS (0.000s) [140.364706] [082/164] (868s left) kms_addfb_basic (no-handle) [140.596419] Starting subtest: no-handle [140.616692] Subtest no-handle: SUCCESS (0.000s) [140.799986] [083/164] (868s left) kms_addfb_basic (size-max) [141.121925] Starting subtest: size-max [141.144703] Subtest size-max: SUCCESS (0.000s) [141.238505] [084/164] (867s left) kms_addfb_basic (small-bo) [141.558166] Starting subtest: small-bo [141.577314] Subtest small-bo: SUCCESS (0.000s) [141.670961] [085/164] (867s left) kms_addfb_basic (tile-pitch-mismatch) [141.902770] Starting subtest: tile-pitch-mismatch [141.924900] Subtest tile-pitch-mismatch: SUCCESS (0.001s) [142.097323] [086/164] (867s left) kms_addfb_basic (too-high) [142.412649] Starting subtest: too-high [142.434143] Subtest too-high: SUCCESS (0.002s) [142.531916] [087/164] (866s left) kms_addfb_basic (too-wide) [142.854386] Starting subtest: too-wide [142.875433] Subtest too-wide: SUCCESS (0.000s) [142.969428] [088/164] (866s left) kms_addfb_basic (unused-handle) [143.197942] Starting subtest: unused-handle [143.217925] Subtest unused-handle: SUCCESS (0.000s) [143.394765] [089/164] (866s left) kms_addfb_basic (unused-modifier) [143.623443] Starting subtest: unused-modifier [143.644191] Subtest unused-modifier: SUCCESS (0.000s) [143.834613] [090/164] (865s left) kms_addfb_basic (unused-offsets) [144.089466] Starting subtest: unused-offsets [144.115236] Subtest unused-offsets: SUCCESS (0.000s) [144.295496] [091/164] (865s left) kms_addfb_basic (unused-pitches) [144.554857] Starting subtest: unused-pitches [144.579836] Subtest unused-pitches: SUCCESS (0.000s) [144.759240] [092/164] (865s left) kms_busy (basic) [145.096061] Starting subtest: basic [145.117191] Starting dynamic subtest: flip [146.046924] Dynamic subtest flip: SUCCESS (0.946s) [146.086159] Starting dynamic subtest: modeset [147.398316] Dynamic subtest modeset: SUCCESS (1.370s) [147.419830] Subtest basic: SUCCESS (2.319s) [147.797252] [093/164] (862s left) kms_prop_blob (basic) [148.045876] Starting subtest: basic [148.066487] Subtest basic: SUCCESS (0.000s) [148.161788] [094/164] (861s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [148.450336] Starting subtest: basic-busy-flip-before-cursor-atomic [148.490205] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [148.584403] [095/164] (861s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [148.903855] Starting subtest: basic-busy-flip-before-cursor-legacy [148.946504] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [149.042219] [096/164] (861s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [149.357433] Starting subtest: basic-flip-after-cursor-atomic [150.425803] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.063s) [150.774637] [097/164] (859s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [151.090997] Starting subtest: basic-flip-after-cursor-legacy [152.148325] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.057s) [152.503526] [098/164] (857s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [152.819613] Starting subtest: basic-flip-after-cursor-varying-size [153.882517] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.081s) [154.260524] [099/164] (856s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [154.573313] Starting subtest: basic-flip-before-cursor-atomic [155.644483] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.068s) [156.017980] [100/164] (854s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [156.337346] Starting subtest: basic-flip-before-cursor-legacy [157.383858] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.052s) [157.739667] [101/164] (853s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [158.056645] Starting subtest: basic-flip-before-cursor-varying-size [159.107854] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.059s) [159.469477] [102/164] (851s left) kms_flip (basic-flip-vs-dpms) [159.798651] Starting subtest: basic-flip-vs-dpms [159.820307] Starting dynamic subtest: A-DP1 [161.009261] Dynamic subtest A-DP1: SUCCESS (1.237s) [161.049239] Starting dynamic subtest: B-DP1 [162.153753] Dynamic subtest B-DP1: SUCCESS (1.133s) [162.195497] Starting dynamic subtest: C-DP1 [163.268645] Dynamic subtest C-DP1: SUCCESS (1.120s) [163.288757] Subtest basic-flip-vs-dpms: SUCCESS (3.499s) [163.697734] [103/164] (847s left) kms_flip (basic-flip-vs-modeset) [164.061574] Starting subtest: basic-flip-vs-modeset [164.090756] Starting dynamic subtest: A-DP1 [165.331744] Dynamic subtest A-DP1: SUCCESS (1.301s) [165.373225] Starting dynamic subtest: B-DP1 [166.437746] Dynamic subtest B-DP1: SUCCESS (1.123s) [166.477076] Starting dynamic subtest: C-DP1 [167.564107] Dynamic subtest C-DP1: SUCCESS (1.124s) [167.584947] Subtest basic-flip-vs-modeset: SUCCESS (3.559s) [167.953799] [104/164] (843s left) kms_flip (basic-flip-vs-wf_vblank) [168.274354] Starting subtest: basic-flip-vs-wf_vblank [168.293904] Starting dynamic subtest: A-DP1 [169.700918] Dynamic subtest A-DP1: SUCCESS (1.452s) [169.739241] Starting dynamic subtest: B-DP1 [171.096526] Dynamic subtest B-DP1: SUCCESS (1.391s) [171.135437] Starting dynamic subtest: C-DP1 [172.493233] Dynamic subtest C-DP1: SUCCESS (1.395s) [172.512521] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.248s) [173.116486] [105/164] (838s left) kms_flip (basic-plain-flip) [173.439537] Starting subtest: basic-plain-flip [173.459807] Starting dynamic subtest: A-DP1 [174.592069] Dynamic subtest A-DP1: SUCCESS (1.176s) [174.631829] Starting dynamic subtest: B-DP1 [175.701961] Dynamic subtest B-DP1: SUCCESS (1.108s) [175.741639] Starting dynamic subtest: C-DP1 [176.817361] Dynamic subtest C-DP1: SUCCESS (1.112s) [176.837763] Subtest basic-plain-flip: SUCCESS (3.406s) [177.271318] [106/164] (833s left) kms_force_connector_basic (force-connector-state) [177.535376] Subtest force-connector-state: SKIP (0.000s) [177.628489] [107/164] (833s left) kms_force_connector_basic (force-edid) [177.878357] Subtest force-edid: SKIP (0.000s) [177.974897] [108/164] (833s left) kms_force_connector_basic (force-load-detect) [178.235649] Subtest force-load-detect: SKIP (0.000s) [178.332627] [109/164] (833s left) kms_force_connector_basic (prune-stale-modes) [178.586074] Subtest prune-stale-modes: SKIP (0.000s) [178.680683] [110/164] (832s left) kms_frontbuffer_tracking (basic) [179.078386] Starting subtest: basic [182.071196] Subtest basic: SUCCESS (3.061s) [182.218123] [111/164] (829s left) kms_hdmi_inject (inject-audio) [182.457751] Subtest inject-audio: SKIP (0.000s) [182.553499] [112/164] (829s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [182.887484] Starting subtest: compare-crc-sanitycheck-xr24 [182.909186] Starting dynamic subtest: pipe-A-DP-1 [183.315701] Dynamic subtest pipe-A-DP-1: SUCCESS (0.429s) [183.379538] Starting dynamic subtest: pipe-B-DP-1 [183.902267] Dynamic subtest pipe-B-DP-1: SUCCESS (0.605s) [183.942041] Starting dynamic subtest: pipe-C-DP-1 [184.544417] Dynamic subtest pipe-C-DP-1: SUCCESS (0.611s) [184.569549] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.659s) [184.910622] [113/164] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [185.227907] Starting subtest: compare-crc-sanitycheck-nv12 [185.250133] Starting dynamic subtest: pipe-A-DP-1 [185.293581] Dynamic subtest pipe-A-DP-1: SKIP (0.001s) [185.332626] Starting dynamic subtest: pipe-B-DP-1 [185.375119] Dynamic subtest pipe-B-DP-1: SKIP (0.001s) [185.415139] Starting dynamic subtest: pipe-C-DP-1 [185.456324] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [185.501847] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s) [185.598464] [114/164] (826s left) kms_pipe_crc_basic (hang-read-crc) [185.900090] Starting subtest: hang-read-crc [185.919801] Starting dynamic subtest: pipe-A-DP-1 [187.337762] Dynamic subtest pipe-A-DP-1: SUCCESS (1.451s) [187.380152] Starting dynamic subtest: pipe-B-DP-1 [188.972461] Dynamic subtest pipe-B-DP-1: SUCCESS (1.631s) [189.013628] Starting dynamic subtest: pipe-C-DP-1 [190.599744] Dynamic subtest pipe-C-DP-1: SUCCESS (1.607s) [190.620964] Subtest hang-read-crc: SUCCESS (4.702s) [190.941543] [115/164] (821s left) kms_pipe_crc_basic (nonblocking-crc) [191.240690] Starting subtest: nonblocking-crc [191.260538] Starting dynamic subtest: pipe-A-DP-1 [191.848129] Dynamic subtest pipe-A-DP-1: SUCCESS (0.573s) [191.888966] Starting dynamic subtest: pipe-B-DP-1 [192.588436] Dynamic subtest pipe-B-DP-1: SUCCESS (0.761s) [192.643336] Starting dynamic subtest: pipe-C-DP-1 [193.359565] Dynamic subtest pipe-C-DP-1: SUCCESS (0.755s) [193.379767] Subtest nonblocking-crc: SUCCESS (2.103s) [193.715459] [116/164] (818s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [194.028163] Starting subtest: nonblocking-crc-frame-sequence [194.056535] Starting dynamic subtest: pipe-A-DP-1 [194.624785] Dynamic subtest pipe-A-DP-1: SUCCESS (0.582s) [194.673584] Starting dynamic subtest: pipe-B-DP-1 [195.364704] Dynamic subtest pipe-B-DP-1: SUCCESS (0.740s) [195.411142] Starting dynamic subtest: pipe-C-DP-1 [196.109959] Dynamic subtest pipe-C-DP-1: SUCCESS (0.751s) [196.131480] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.087s) [196.481633] [117/164] (815s left) kms_pipe_crc_basic (read-crc) [196.787841] Starting subtest: read-crc [196.810379] Starting dynamic subtest: pipe-A-DP-1 [197.312822] Dynamic subtest pipe-A-DP-1: SUCCESS (0.522s) [197.367808] Starting dynamic subtest: pipe-B-DP-1 [197.994035] Dynamic subtest pipe-B-DP-1: SUCCESS (0.677s) [198.035794] Starting dynamic subtest: pipe-C-DP-1 [198.685540] Dynamic subtest pipe-C-DP-1: SUCCESS (0.687s) [198.706281] Subtest read-crc: SUCCESS (1.900s) [199.052531] [118/164] (813s left) kms_pipe_crc_basic (read-crc-frame-sequence) [199.367040] Starting subtest: read-crc-frame-sequence [199.390309] Starting dynamic subtest: pipe-A-DP-1 [199.890331] Dynamic subtest pipe-A-DP-1: SUCCESS (0.521s) [199.930866] Starting dynamic subtest: pipe-B-DP-1 [200.587975] Dynamic subtest pipe-B-DP-1: SUCCESS (0.694s) [200.632537] Starting dynamic subtest: pipe-C-DP-1 [201.283703] Dynamic subtest pipe-C-DP-1: SUCCESS (0.685s) [201.306554] Subtest read-crc-frame-sequence: SUCCESS (1.915s) [201.644129] [119/164] (810s left) kms_pm_backlight (basic-brightness) [201.976432] Subtest basic-brightness: SKIP (0.000s) [202.075846] [120/164] (810s left) kms_psr (primary_page_flip) [202.342169] Subtest primary_page_flip: SKIP (0.000s) [202.459307] [121/164] (810s left) kms_psr (cursor_plane_move) [202.761072] Subtest cursor_plane_move: SKIP (0.000s) [202.885734] [122/164] (809s left) kms_psr (sprite_plane_onoff) [203.189115] Subtest sprite_plane_onoff: SKIP (0.000s) [203.311862] [123/164] (809s left) kms_psr (primary_mmap_gtt) [203.582640] Subtest primary_mmap_gtt: SKIP (0.000s) [203.685083] [124/164] (809s left) kms_setmode (basic-clone-single-crtc) [203.929232] Starting subtest: basic-clone-single-crtc [203.995484] Subtest basic-clone-single-crtc: SKIP (0.000s) [204.093083] [125/164] (809s left) i915_pm_rpm (basic-pci-d3-state) [205.989190] Starting subtest: basic-pci-d3-state [206.853111] Subtest basic-pci-d3-state: SUCCESS (0.853s) [207.075808] [126/164] (806s left) i915_pm_rpm (basic-rte) [207.290670] Starting subtest: basic-rte [209.680042] Subtest basic-rte: SUCCESS (2.394s) [210.569490] [127/164] (802s left) i915_pm_rps (basic-api) [210.813381] Starting subtest: basic-api [210.836102] Subtest basic-api: SUCCESS (0.007s) [210.956332] [128/164] (802s left) prime_self_import (basic-llseek-bad) [211.176165] Starting subtest: basic-llseek-bad [211.220113] Subtest basic-llseek-bad: SUCCESS (0.004s) [211.324890] [129/164] (802s left) prime_self_import (basic-llseek-size) [211.539400] Starting subtest: basic-llseek-size [211.583738] Subtest basic-llseek-size: SUCCESS (0.006s) [211.681512] [130/164] (801s left) prime_self_import (basic-with_fd_dup) [211.877718] Starting subtest: basic-with_fd_dup [211.919497] Subtest basic-with_fd_dup: SUCCESS (0.007s) [212.016810] [131/164] (801s left) prime_self_import (basic-with_one_bo) [212.234445] Starting subtest: basic-with_one_bo [212.278683] Subtest basic-with_one_bo: SUCCESS (0.007s) [212.378728] [132/164] (801s left) prime_self_import (basic-with_one_bo_two_files) [212.594331] Starting subtest: basic-with_one_bo_two_files [212.656390] Subtest basic-with_one_bo_two_files: SUCCESS (0.006s) [212.759856] [133/164] (801s left) prime_self_import (basic-with_two_bos) [212.985664] Starting subtest: basic-with_two_bos [213.036638] Subtest basic-with_two_bos: SUCCESS (0.007s) [213.143276] [134/164] (800s left) prime_vgem (basic-fence-flip) [213.413286] Starting subtest: basic-fence-flip [213.977415] Subtest basic-fence-flip: SUCCESS (0.603s) [214.132131] [135/164] (800s left) prime_vgem (basic-fence-mmap) [214.394480] Starting subtest: basic-fence-mmap [214.441332] Subtest basic-fence-mmap: SUCCESS (0.074s) [214.559225] [136/164] (799s left) prime_vgem (basic-fence-read) [214.811863] Starting subtest: basic-fence-read [214.895791] Subtest basic-fence-read: SUCCESS (0.112s) [215.027283] [137/164] (799s left) prime_vgem (basic-gtt) [215.284240] Starting subtest: basic-gtt [215.305903] Subtest basic-gtt: SUCCESS (0.036s) [215.447353] [138/164] (799s left) prime_vgem (basic-read) [215.706153] Starting subtest: basic-read [215.726553] Subtest basic-read: SUCCESS (0.055s) [215.877166] [139/164] (798s left) prime_vgem (basic-write) [216.122209] Starting subtest: basic-write [216.165553] Subtest basic-write: SUCCESS (0.066s) [216.292277] [140/164] (798s left) vgem_basic (setversion) [216.539944] Starting subtest: setversion [216.583245] Subtest setversion: SUCCESS (0.000s) [216.682259] [141/164] (798s left) vgem_basic (create) [216.920352] Starting subtest: create [216.942664] Subtest create: SUCCESS (0.000s) [217.041435] [142/164] (797s left) vgem_basic (debugfs) [217.275523] Starting subtest: debugfs [217.297222] Subtest debugfs: SUCCESS (0.001s) [217.394543] [143/164] (797s left) vgem_basic (dmabuf-export) [217.634950] Starting subtest: dmabuf-export [217.677647] Subtest dmabuf-export: SUCCESS (0.016s) [217.778264] [144/164] (797s left) vgem_basic (dmabuf-fence) [218.013228] Starting subtest: dmabuf-fence [218.035845] Subtest dmabuf-fence: SUCCESS (0.002s) [218.132558] [145/164] (797s left) vgem_basic (dmabuf-fence-before) [218.370856] Starting subtest: dmabuf-fence-before [218.392818] Subtest dmabuf-fence-before: SUCCESS (0.001s) [218.492314] [146/164] (796s left) vgem_basic (dmabuf-mmap) [218.731967] Starting subtest: dmabuf-mmap [218.755297] Subtest dmabuf-mmap: SUCCESS (0.044s) [218.857114] [147/164] (796s left) vgem_basic (mmap) [219.095707] Starting subtest: mmap [219.116746] Subtest mmap: SUCCESS (0.026s) [219.216333] [148/164] (796s left) vgem_basic (second-client) [219.454765] Starting subtest: second-client [219.499787] Subtest second-client: SUCCESS (0.033s) [219.599806] [149/164] (796s left) vgem_basic (sysfs) [219.834943] Starting subtest: sysfs [219.857611] Subtest sysfs: SUCCESS (0.001s) [219.954255] [150/164] (795s left) core_hotunplug (unbind-rebind) [220.271729] Starting subtest: unbind-rebind [224.175660] Subtest unbind-rebind: SUCCESS (3.900s) [224.277691] [151/164] (791s left) vgem_basic (unload) [224.508581] Starting subtest: unload [253.700320] Subtest unload: SUCCESS (29.046s) [253.797316] [152/164] (762s left) i915_module_load (reload) [254.013809] Starting subtest: reload [257.569046] Subtest reload: SUCCESS (3.574s) [257.706973] [153/164] (758s left) gem_lmem_swapping (basic) [257.996362] Subtest basic: SKIP (0.000s) [258.093422] [154/164] (758s left) gem_lmem_swapping (parallel-random-engines) [258.331989] Subtest parallel-random-engines: SKIP (0.000s) [258.427186] [155/164] (757s left) gem_lmem_swapping (random-engines) [258.667789] Subtest random-engines: SKIP (0.000s) [258.763621] [156/164] (757s left) gem_lmem_swapping (verify-random) [259.019253] Subtest verify-random: SKIP (0.000s) [259.117106] [157/164] (757s left) i915_pm_rpm (module-reload) [261.305908] Starting subtest: module-reload [272.409603] Subtest module-reload: SUCCESS (11.106s) [272.501783] [158/164] (744s left) i915_selftest (live) [272.718323] Starting subtest: live [272.738639] Starting dynamic subtest: sanitycheck [274.182288] Dynamic subtest sanitycheck: SUCCESS (1.459s) [274.228641] Starting dynamic subtest: uncore [275.845297] Dynamic subtest uncore: SUCCESS (1.659s) [275.883157] Starting dynamic subtest: workarounds [277.763963] Dynamic subtest workarounds: SUCCESS (1.914s) [277.810414] Starting dynamic subtest: gt_engines [279.884555] Dynamic subtest gt_engines: SUCCESS (2.116s) [279.922049] Starting dynamic subtest: gt_timelines [302.857341] Dynamic subtest gt_timelines: SUCCESS (22.960s) [302.912062] Starting dynamic subtest: gt_contexts [304.532156] Dynamic subtest gt_contexts: SUCCESS (1.678s) [304.578113] Starting dynamic subtest: gt_lrc [308.842637] Dynamic subtest gt_lrc: SUCCESS (4.306s) [308.891086] Starting dynamic subtest: gt_mocs [310.516591] Dynamic subtest gt_mocs: SUCCESS (1.673s) [310.566171] Starting dynamic subtest: gt_pm [319.714951] Dynamic subtest gt_pm: SUCCESS (9.193s) [319.762544] Starting dynamic subtest: gt_heartbeat [321.378458] Dynamic subtest gt_heartbeat: SUCCESS (1.661s) [321.413189] Starting dynamic subtest: gt_tlb [323.925923] Dynamic subtest gt_tlb: SUCCESS (2.543s) [323.963290] Starting dynamic subtest: requests [331.925357] Dynamic subtest requests: SUCCESS (7.995s) [331.967687] Starting dynamic subtest: migrate [336.883065] Dynamic subtest migrate: SUCCESS (4.956s) [336.918754] Starting dynamic subtest: active [338.446849] Dynamic subtest active: SUCCESS (1.559s) [338.495590] Starting dynamic subtest: objects [343.097836] Dynamic subtest objects: SUCCESS (4.649s) [343.132789] Starting dynamic subtest: mman [352.076687] Dynamic subtest mman: SUCCESS (8.974s) [352.111799] Starting dynamic subtest: dmabuf [353.627927] Dynamic subtest dmabuf: SUCCESS (1.542s) [353.681857] Starting dynamic subtest: vma [355.192611] Dynamic subtest vma: SUCCESS (1.564s) [355.230307] Starting dynamic subtest: coherency [364.694260] Dynamic subtest coherency: SUCCESS (9.504s) [364.729289] Starting dynamic subtest: gtt [374.223636] Dynamic subtest gtt: SUCCESS (9.526s) [374.263256] Starting dynamic subtest: gem [377.085593] Dynamic subtest gem: SUCCESS (2.857s) [377.134807] Starting dynamic subtest: evict [383.305689] Dynamic subtest evict: SUCCESS (6.214s) [383.353356] Starting dynamic subtest: hugepages [391.637366] Dynamic subtest hugepages: SUCCESS (8.330s) [391.684409] Starting dynamic subtest: gem_contexts [416.716605] Dynamic subtest gem_contexts: SUCCESS (24.904s) [416.754235] Starting dynamic subtest: client [418.218088] Dynamic subtest client: SUCCESS (1.670s) [418.268105] Starting dynamic subtest: gem_migrate [419.955283] Dynamic subtest gem_migrate: SUCCESS (1.733s) [420.003419] Starting dynamic subtest: reset [432.791694] Dynamic subtest reset: SUCCESS (12.834s) [432.828281] Starting dynamic subtest: memory_region [434.460315] Dynamic subtest memory_region: SUCCESS (1.663s) [434.498079] Starting dynamic subtest: hangcheck [459.433348] Dynamic subtest hangcheck: SUCCESS (24.968s) [459.482751] Starting dynamic subtest: execlists [472.111742] Dynamic subtest execlists: SUCCESS (12.678s) [472.159572] Starting dynamic subtest: ring_submission [473.743846] Dynamic subtest ring_submission: SUCCESS (1.629s) [473.782371] Starting dynamic subtest: perf [475.436247] Dynamic subtest perf: SUCCESS (1.679s) [475.480306] Starting dynamic subtest: slpc [477.170302] Dynamic subtest slpc: SUCCESS (1.739s) [477.207934] Starting dynamic subtest: guc [478.886531] Dynamic subtest guc: SUCCESS (1.714s) [478.921902] Starting dynamic subtest: guc_multi_lrc [480.624276] Dynamic subtest guc_multi_lrc: SUCCESS (1.734s) [480.676116] Starting dynamic subtest: guc_hang [482.193445] Dynamic subtest guc_hang: SUCCESS (1.558s) [482.229188] Starting dynamic subtest: late_gt_pm [483.796351] Dynamic subtest late_gt_pm: SUCCESS (1.604s) [483.818562] Subtest live: SUCCESS (211.075s) [483.909938] [159/164] (532s left) dmabuf (all-tests) [484.118537] Starting subtest: all-tests [484.140208] Starting dynamic subtest: sanitycheck [484.206041] Dynamic subtest sanitycheck: SUCCESS (0.087s) [484.246867] Starting dynamic subtest: dma_fence [484.392047] Dynamic subtest dma_fence: SUCCESS (0.183s) [484.428850] Starting dynamic subtest: dma_fence_chain [507.791081] Dynamic subtest dma_fence_chain: SUCCESS (23.393s) [507.832473] Starting dynamic subtest: dma_fence_unwrap [507.873835] Dynamic subtest dma_fence_unwrap: SUCCESS (0.082s) [507.915337] Starting dynamic subtest: dma_resv [507.960266] Dynamic subtest dma_resv: SUCCESS (0.073s) [507.980331] Subtest all-tests: SUCCESS (23.833s) [508.073571] [160/164] (508s left) i915_suspend (basic-s2idle-without-i915) [508.281044] Starting subtest: basic-s2idle-without-i915 [529.443674] Subtest basic-s2idle-without-i915: SUCCESS (5.175s) [534.140875] [161/164] (503s left) i915_suspend (basic-s3-without-i915) [534.343269] Starting subtest: basic-s3-without-i915 [552.334114] Subtest basic-s3-without-i915: SUCCESS (3.203s) [556.047288] [162/164] (499s left) gem_exec_suspend (basic-s0) [556.323079] Starting subtest: basic-S0 [556.347283] Starting dynamic subtest: smem [578.099827] Dynamic subtest smem: SUCCESS (5.796s) [578.121161] Subtest basic-S0: SUCCESS (5.799s) [580.489910] [163/164] (493s left) gem_exec_suspend (basic-s3) [580.723327] Starting subtest: basic-S3 [580.742485] Starting dynamic subtest: smem [601.420314] Dynamic subtest smem: SUCCESS (5.737s) [601.442868] Subtest basic-S3: SUCCESS (5.740s) [605.819298] [164/164] (486s left) kms_pipe_crc_basic (suspend-read-crc) [606.145886] Starting subtest: suspend-read-crc [606.168510] Starting dynamic subtest: pipe-A-DP-1 [624.277295] Dynamic subtest pipe-A-DP-1: SUCCESS (2.228s) [624.326732] Starting dynamic subtest: pipe-B-DP-1 [643.271866] Dynamic subtest pipe-B-DP-1: SUCCESS (2.506s) [652.471730] Closing watchdogs Done.