[45.600080] Initializing watchdogs [45.600164] /dev/watchdog0 [45.610154] [001/165] (960s left) i915_module_load (load) [45.680136] Starting subtest: load [47.975415] Subtest load: SUCCESS (2.295s) [48.004829] [002/165] (958s left) core_auth (basic-auth) [48.109332] Starting subtest: basic-auth [48.112832] Subtest basic-auth: SUCCESS (0.001s) [48.193856] [003/165] (957s left) debugfs_test (read_all_entries) [48.300430] Starting subtest: read_all_entries [48.441540] Subtest read_all_entries: SUCCESS (0.140s) [48.742496] [004/165] (957s left) debugfs_test (basic-hwmon) [48.817740] Starting subtest: basic-hwmon [48.824292] Subtest basic-hwmon: SKIP (0.000s) [49.092056] [005/165] (957s left) fbdev (eof) [49.187954] Starting subtest: eof [49.191572] Subtest eof: SUCCESS (0.001s) [49.253685] [006/165] (956s left) fbdev (info) [49.337572] Starting subtest: info [49.340767] Subtest info: SUCCESS (0.000s) [49.395736] [007/165] (956s left) fbdev (nullptr) [49.475332] Starting subtest: nullptr [49.478843] Subtest nullptr: SUCCESS (0.000s) [49.535141] [008/165] (956s left) fbdev (read) [49.625543] Starting subtest: read [49.915375] Subtest read: SUCCESS (0.256s) [50.206603] [009/165] (956s left) fbdev (write) [50.532310] Starting subtest: write [50.663581] Subtest write: SUCCESS (0.162s) [50.958526] [010/165] (955s left) gem_basic (bad-close) [51.188727] Starting subtest: bad-close [51.198164] Subtest bad-close: SUCCESS (0.000s) [51.283148] [011/165] (955s left) gem_basic (create-close) [51.355113] Starting subtest: create-close [51.361611] Subtest create-close: SUCCESS (0.000s) [51.443837] [012/165] (955s left) gem_basic (create-fd-close) [51.510987] Starting subtest: create-fd-close [51.517061] Subtest create-fd-close: SUCCESS (0.000s) [51.616565] [013/165] (955s left) gem_busy (busy@all-engines) [51.720521] Starting subtest: busy [51.723649] Starting dynamic subtest: all-engines [51.784380] Dynamic subtest all-engines: SUCCESS (0.064s) [51.787570] Subtest busy: SUCCESS (0.064s) [52.181161] [014/165] (954s left) gem_close_race (basic-process) [52.261462] Starting subtest: basic-process [52.323766] Subtest basic-process: SUCCESS (0.062s) [52.545569] [015/165] (954s left) gem_close_race (basic-threads) [52.643663] Starting subtest: basic-threads [53.847059] Subtest basic-threads: SUCCESS (1.203s) [54.058695] [016/165] (952s left) gem_ctx_create (basic) [54.153065] Starting subtest: basic [54.156335] Subtest basic: SUCCESS (0.000s) [54.350880] [017/165] (952s left) gem_ctx_create (basic-files) [54.423847] Starting subtest: basic-files [56.447765] Subtest basic-files: SUCCESS (2.018s) [56.902619] [018/165] (950s left) gem_ctx_exec (basic) [57.389993] Starting subtest: basic [57.456269] Subtest basic: SUCCESS (0.013s) [57.685579] [019/165] (949s left) gem_exec_basic (basic) [58.015084] Starting subtest: basic [58.018484] Starting dynamic subtest: rcs0-smem [58.021712] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [58.030088] Starting dynamic subtest: bcs0-smem [58.033125] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [58.041504] Starting dynamic subtest: vcs0-smem [58.044806] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [58.053042] Starting dynamic subtest: vcs1-smem [58.056224] Dynamic subtest vcs1-smem: SUCCESS (0.000s) [58.064711] Starting dynamic subtest: vecs0-smem [58.068062] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [58.071820] Subtest basic: SUCCESS (0.005s) [58.247063] [020/165] (949s left) gem_exec_create (basic) [58.348113] Starting subtest: basic [58.353491] Starting dynamic subtest: smem [60.388274] Dynamic subtest smem: SUCCESS (2.043s) [60.391480] Subtest basic: SUCCESS (2.043s) [60.595789] [021/165] (946s left) gem_exec_fence (basic-busy) [60.822734] Starting subtest: basic-busy [60.826386] Starting dynamic subtest: rcs0 [60.849922] Dynamic subtest rcs0: SUCCESS (0.027s) [60.863483] Starting dynamic subtest: bcs0 [60.878675] Dynamic subtest bcs0: SUCCESS (0.027s) [60.893085] Starting dynamic subtest: vcs0 [60.903886] Dynamic subtest vcs0: SUCCESS (0.025s) [60.918726] Starting dynamic subtest: vcs1 [60.929529] Dynamic subtest vcs1: SUCCESS (0.025s) [60.943513] Starting dynamic subtest: vecs0 [60.955754] Dynamic subtest vecs0: SUCCESS (0.029s) [60.959342] Subtest basic-busy: SUCCESS (0.133s) [61.626549] [022/165] (945s left) gem_exec_fence (basic-wait) [61.830118] Starting subtest: basic-wait [61.833955] Starting dynamic subtest: rcs0 [61.859432] Dynamic subtest rcs0: SUCCESS (0.030s) [61.878209] Starting dynamic subtest: bcs0 [61.885321] Dynamic subtest bcs0: SUCCESS (0.025s) [61.897966] Starting dynamic subtest: vcs0 [61.907250] Dynamic subtest vcs0: SUCCESS (0.024s) [61.918936] Starting dynamic subtest: vcs1 [61.936384] Dynamic subtest vcs1: SUCCESS (0.029s) [61.948110] Starting dynamic subtest: vecs0 [61.979993] Dynamic subtest vecs0: SUCCESS (0.043s) [61.983953] Subtest basic-wait: SUCCESS (0.152s) [62.616086] [023/165] (944s left) gem_exec_fence (basic-await) [62.818885] Starting subtest: basic-await [62.822752] Starting dynamic subtest: rcs0 [62.931440] Dynamic subtest rcs0: SUCCESS (0.113s) [62.947174] Starting dynamic subtest: bcs0 [63.035390] Dynamic subtest bcs0: SUCCESS (0.104s) [63.046563] Starting dynamic subtest: vcs0 [63.145152] Dynamic subtest vcs0: SUCCESS (0.109s) [63.155164] Starting dynamic subtest: vcs1 [63.257271] Dynamic subtest vcs1: SUCCESS (0.111s) [63.271434] Starting dynamic subtest: vecs0 [63.395805] Dynamic subtest vecs0: SUCCESS (0.139s) [63.399787] Subtest basic-await: SUCCESS (0.578s) [64.049197] [024/165] (943s left) gem_exec_fence (nb-await) [64.297148] Starting subtest: nb-await [64.300891] Starting dynamic subtest: rcs0 [64.370660] Dynamic subtest rcs0: SUCCESS (0.074s) [64.389274] Starting dynamic subtest: bcs0 [64.444254] Dynamic subtest bcs0: SUCCESS (0.073s) [64.460588] Starting dynamic subtest: vcs0 [64.515746] Dynamic subtest vcs0: SUCCESS (0.071s) [64.533369] Starting dynamic subtest: vcs1 [64.588443] Dynamic subtest vcs1: SUCCESS (0.070s) [64.607814] Starting dynamic subtest: vecs0 [64.661222] Dynamic subtest vecs0: SUCCESS (0.075s) [64.665307] Subtest nb-await: SUCCESS (0.365s) [65.269474] [025/165] (942s left) gem_exec_gttfill (basic) [65.370331] Starting subtest: basic [69.959421] Subtest basic: SUCCESS (4.591s) [70.133132] [026/165] (937s left) gem_exec_parallel (engines) [70.254192] Starting subtest: engines [70.257376] Starting dynamic subtest: basic [72.232294] Dynamic subtest basic: SUCCESS (1.977s) [72.241140] Starting dynamic subtest: contexts [77.696123] Dynamic subtest contexts: SUCCESS (5.464s) [77.705264] Starting dynamic subtest: fds [84.341417] Dynamic subtest fds: SUCCESS (6.645s) [84.350781] Starting dynamic subtest: userptr [86.583441] Dynamic subtest userptr: SUCCESS (2.242s) [86.586746] Subtest engines: SUCCESS (16.329s) [86.788037] [027/165] (920s left) gem_exec_store (basic) [86.873148] Starting subtest: basic [86.906520] Subtest basic: SUCCESS (0.040s) [87.116931] [028/165] (920s left) gem_flink_basic (bad-flink) [87.205522] Starting subtest: bad-flink [87.209053] Subtest bad-flink: SUCCESS (0.000s) [87.265329] [029/165] (920s left) gem_flink_basic (bad-open) [87.341809] Starting subtest: bad-open [87.345050] Subtest bad-open: SUCCESS (0.000s) [87.416087] [030/165] (920s left) gem_flink_basic (basic) [87.500242] Starting subtest: basic [87.503537] Subtest basic: SUCCESS (0.000s) [87.599660] [031/165] (920s left) gem_flink_basic (double-flink) [87.691522] Starting subtest: double-flink [87.694637] Subtest double-flink: SUCCESS (0.000s) [87.770818] [032/165] (919s left) gem_flink_basic (flink-lifetime) [87.857752] Starting subtest: flink-lifetime [87.860869] Subtest flink-lifetime: SUCCESS (0.001s) [87.941376] [033/165] (919s left) gem_huc_copy (huc-copy) [88.035974] Starting subtest: huc-copy [88.042222] Subtest huc-copy: SKIP (0.000s) [88.151223] [034/165] (919s left) gem_linear_blits (basic) [88.356523] Starting subtest: basic [88.364826] Subtest basic: SUCCESS (0.007s) [88.517825] [035/165] (919s left) gem_mmap (basic) [88.681427] Starting subtest: basic [88.696487] Subtest basic: SUCCESS (0.000s) [88.775198] [036/165] (919s left) gem_mmap_gtt (basic) [88.868487] Starting subtest: basic [88.871656] Subtest basic: SUCCESS (0.001s) [88.920252] [037/165] (918s left) gem_render_linear_blits (basic) [88.991808] Starting subtest: basic [89.020100] Subtest basic: SUCCESS (0.031s) [89.053033] [038/165] (918s left) gem_render_tiled_blits (basic) [89.122499] Starting subtest: basic [89.157782] Subtest basic: SUCCESS (0.036s) [89.203316] [039/165] (918s left) gem_ringfill (basic-all) [89.448272] Starting subtest: basic-all [90.627259] Subtest basic-all: SUCCESS (1.175s) [90.732119] [040/165] (917s left) gem_softpin (allocator-basic) [90.825558] Starting subtest: allocator-basic [90.939415] Subtest allocator-basic: SUCCESS (0.115s) [91.046344] [041/165] (916s left) gem_softpin (allocator-basic-reserve) [91.129826] Starting subtest: allocator-basic-reserve [91.243611] Subtest allocator-basic-reserve: SUCCESS (0.115s) [91.370521] [042/165] (916s left) gem_softpin (safe-alignment) [91.461177] Starting subtest: safe-alignment [91.474326] Subtest safe-alignment: SUCCESS (0.014s) [91.597311] [043/165] (916s left) gem_sync (basic-all) [91.719830] Starting subtest: basic-all [94.002685] Subtest basic-all: SUCCESS (2.302s) [94.212465] [044/165] (913s left) gem_sync (basic-each) [94.327056] Starting subtest: basic-each [96.559186] Subtest basic-each: SUCCESS (2.252s) [96.769492] [045/165] (911s left) gem_tiled_blits (basic) [96.977180] Starting subtest: basic [96.996693] Subtest basic: SUCCESS (0.019s) [97.153493] [046/165] (911s left) gem_tiled_fence_blits (basic) [97.428346] Starting subtest: basic [97.439124] Subtest basic: SUCCESS (0.010s) [97.581497] [047/165] (910s left) gem_tiled_pread_basic [98.134099] [048/165] (910s left) gem_wait (busy@all-engines) [98.652633] Starting subtest: busy [98.717679] Starting dynamic subtest: all-engines [99.136450] Dynamic subtest all-engines: SUCCESS (0.520s) [99.282490] Subtest busy: SUCCESS (0.520s) [99.567496] [049/165] (909s left) gem_wait (wait@all-engines) [100.050824] Starting subtest: wait [100.118073] Starting dynamic subtest: all-engines [100.940294] Dynamic subtest all-engines: SUCCESS (1.037s) [100.944226] Subtest wait: SUCCESS (1.038s) [101.184401] [050/165] (907s left) i915_getparams_basic (basic-eu-total) [101.275272] Starting subtest: basic-eu-total [101.281902] Subtest basic-eu-total: SUCCESS (0.000s) [101.349788] [051/165] (907s left) i915_getparams_basic (basic-subslice-total) [101.429324] Starting subtest: basic-subslice-total [101.435749] Subtest basic-subslice-total: SUCCESS (0.000s) [101.502393] [052/165] (907s left) i915_hangman (error-state-basic) [101.592812] Starting subtest: error-state-basic [101.602680] Subtest error-state-basic: SUCCESS (0.007s) [101.673824] [053/165] (907s left) i915_pciid [101.808435] [054/165] (906s left) kms_addfb_basic (addfb25-4-tiled) [102.097294] Starting subtest: addfb25-4-tiled [102.100393] Subtest addfb25-4-tiled: SUCCESS (0.000s) [102.175191] [055/165] (906s left) kms_addfb_basic (addfb25-bad-modifier) [102.249404] Starting subtest: addfb25-bad-modifier [102.252496] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [102.552510] [056/165] (906s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [102.639049] Starting subtest: addfb25-framebuffer-vs-set-tiling [102.642134] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [102.931085] [057/165] (905s left) kms_addfb_basic (addfb25-modifier-no-flag) [103.009391] Starting subtest: addfb25-modifier-no-flag [103.012635] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [103.316387] [058/165] (905s left) kms_addfb_basic (addfb25-x-tiled-legacy) [103.413795] Starting subtest: addfb25-x-tiled-legacy [103.417200] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [103.708172] [059/165] (905s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [103.781812] Starting subtest: addfb25-x-tiled-mismatch-legacy [103.784678] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [104.079450] [060/165] (904s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [104.385296] Starting subtest: addfb25-yf-tiled-legacy [104.388359] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [104.458026] [061/165] (904s left) kms_addfb_basic (addfb25-y-tiled-legacy) [104.744055] Starting subtest: addfb25-y-tiled-legacy [104.748142] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [104.831541] [062/165] (904s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [105.117712] Starting subtest: addfb25-y-tiled-small-legacy [105.120580] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [105.197524] [063/165] (903s left) kms_addfb_basic (bad-pitch-0) [105.280634] Starting subtest: bad-pitch-0 [105.284205] Subtest bad-pitch-0: SUCCESS (0.000s) [105.583763] [064/165] (903s left) kms_addfb_basic (bad-pitch-1024) [105.671151] Starting subtest: bad-pitch-1024 [105.674432] Subtest bad-pitch-1024: SUCCESS (0.000s) [105.984763] [065/165] (903s left) kms_addfb_basic (bad-pitch-128) [106.073186] Starting subtest: bad-pitch-128 [106.076306] Subtest bad-pitch-128: SUCCESS (0.000s) [106.374836] [066/165] (902s left) kms_addfb_basic (bad-pitch-256) [106.451014] Starting subtest: bad-pitch-256 [106.454535] Subtest bad-pitch-256: SUCCESS (0.000s) [106.744856] [067/165] (902s left) kms_addfb_basic (bad-pitch-32) [106.834545] Starting subtest: bad-pitch-32 [106.837922] Subtest bad-pitch-32: SUCCESS (0.000s) [107.129822] [068/165] (902s left) kms_addfb_basic (bad-pitch-63) [107.214676] Starting subtest: bad-pitch-63 [107.217875] Subtest bad-pitch-63: SUCCESS (0.000s) [107.512152] [069/165] (901s left) kms_addfb_basic (bad-pitch-65536) [107.582706] Starting subtest: bad-pitch-65536 [107.585860] Subtest bad-pitch-65536: SUCCESS (0.000s) [107.885194] [070/165] (901s left) kms_addfb_basic (bad-pitch-999) [107.977588] Starting subtest: bad-pitch-999 [107.980644] Subtest bad-pitch-999: SUCCESS (0.000s) [108.282299] [071/165] (900s left) kms_addfb_basic (basic) [108.372647] Starting subtest: basic [108.375801] Subtest basic: SUCCESS (0.000s) [108.667195] [072/165] (900s left) kms_addfb_basic (basic-x-tiled-legacy) [108.752435] Starting subtest: basic-x-tiled-legacy [108.755435] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [109.048076] [073/165] (900s left) kms_addfb_basic (basic-y-tiled-legacy) [109.127589] Starting subtest: basic-y-tiled-legacy [109.130770] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [109.414300] [074/165] (899s left) kms_addfb_basic (bo-too-small) [109.711741] Starting subtest: bo-too-small [109.714400] Subtest bo-too-small: SUCCESS (0.000s) [109.795136] [075/165] (899s left) kms_addfb_basic (bo-too-small-due-to-tiling) [110.079594] Starting subtest: bo-too-small-due-to-tiling [110.082230] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [110.160802] [076/165] (899s left) kms_addfb_basic (clobberred-modifier) [110.230973] Starting subtest: clobberred-modifier [110.234175] Subtest clobberred-modifier: SUCCESS (0.000s) [110.535200] [077/165] (898s left) kms_addfb_basic (framebuffer-vs-set-tiling) [110.623492] Starting subtest: framebuffer-vs-set-tiling [110.626509] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [110.933176] [078/165] (898s left) kms_addfb_basic (invalid-get-prop) [111.026897] Starting subtest: invalid-get-prop [111.030048] Subtest invalid-get-prop: SUCCESS (0.000s) [111.341126] [079/165] (898s left) kms_addfb_basic (invalid-get-prop-any) [111.450375] Starting subtest: invalid-get-prop-any [111.453626] Subtest invalid-get-prop-any: SUCCESS (0.000s) [111.749382] [080/165] (897s left) kms_addfb_basic (invalid-set-prop) [111.828277] Starting subtest: invalid-set-prop [111.831431] Subtest invalid-set-prop: SUCCESS (0.000s) [112.114954] [081/165] (897s left) kms_addfb_basic (invalid-set-prop-any) [112.198150] Starting subtest: invalid-set-prop-any [112.201445] Subtest invalid-set-prop-any: SUCCESS (0.000s) [112.477421] [082/165] (897s left) kms_addfb_basic (no-handle) [112.545046] Starting subtest: no-handle [112.548442] Subtest no-handle: SUCCESS (0.000s) [112.830948] [083/165] (896s left) kms_addfb_basic (size-max) [113.114659] Starting subtest: size-max [113.117493] Subtest size-max: SUCCESS (0.000s) [113.202589] [084/165] (896s left) kms_addfb_basic (small-bo) [113.504136] Starting subtest: small-bo [113.506817] Subtest small-bo: SUCCESS (0.000s) [113.577614] [085/165] (896s left) kms_addfb_basic (tile-pitch-mismatch) [113.646138] Starting subtest: tile-pitch-mismatch [113.649291] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [113.954178] [086/165] (895s left) kms_addfb_basic (too-high) [114.262841] Starting subtest: too-high [114.265492] Subtest too-high: SUCCESS (0.001s) [114.344095] [087/165] (895s left) kms_addfb_basic (too-wide) [114.619857] Starting subtest: too-wide [114.622697] Subtest too-wide: SUCCESS (0.000s) [114.697508] [088/165] (895s left) kms_addfb_basic (unused-handle) [114.775816] Starting subtest: unused-handle [114.779205] Subtest unused-handle: SUCCESS (0.000s) [115.060946] [089/165] (894s left) kms_addfb_basic (unused-modifier) [115.128510] Starting subtest: unused-modifier [115.131826] Subtest unused-modifier: SUCCESS (0.000s) [115.435983] [090/165] (894s left) kms_addfb_basic (unused-offsets) [115.535043] Starting subtest: unused-offsets [115.538611] Subtest unused-offsets: SUCCESS (0.000s) [115.832716] [091/165] (893s left) kms_addfb_basic (unused-pitches) [115.915382] Starting subtest: unused-pitches [115.918585] Subtest unused-pitches: SUCCESS (0.000s) [116.218090] [092/165] (893s left) kms_busy (basic) [116.518771] Starting subtest: basic [116.521925] Starting dynamic subtest: flip [117.330229] Dynamic subtest flip: SUCCESS (0.805s) [117.339891] Starting dynamic subtest: modeset [118.492207] Dynamic subtest modeset: SUCCESS (1.162s) [118.495634] Subtest basic: SUCCESS (1.971s) [118.943397] [093/165] (890s left) kms_prop_blob (basic) [119.014728] Starting subtest: basic [119.017870] Subtest basic: SUCCESS (0.000s) [119.073419] [094/165] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [119.357257] Starting subtest: basic-busy-flip-before-cursor-atomic [119.362671] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [119.420921] [095/165] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [119.698613] Starting subtest: basic-busy-flip-before-cursor-legacy [119.704353] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [119.754404] [096/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [120.034217] Starting subtest: basic-flip-after-cursor-atomic [121.131153] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.022s) [121.686245] [097/165] (888s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [122.015719] Starting subtest: basic-flip-after-cursor-legacy [123.036254] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.022s) [123.464867] [098/165] (886s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [123.780985] Starting subtest: basic-flip-after-cursor-varying-size [124.810411] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.032s) [125.204945] [099/165] (885s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [125.502269] Starting subtest: basic-flip-before-cursor-atomic [126.549036] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.046s) [126.969864] [100/165] (883s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [127.271292] Starting subtest: basic-flip-before-cursor-legacy [128.311444] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.040s) [128.708505] [101/165] (881s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [129.006450] Starting subtest: basic-flip-before-cursor-varying-size [130.127540] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.027s) [130.654772] [102/165] (879s left) kms_dsc (dsc-basic) [130.966290] Subtest dsc-basic: SKIP (0.000s) [130.996104] [103/165] (879s left) kms_flip (basic-flip-vs-dpms) [131.251117] Starting subtest: basic-flip-vs-dpms [131.257066] Starting dynamic subtest: A-DP1 [132.413408] Dynamic subtest A-DP1: SUCCESS (1.156s) [132.435489] Starting dynamic subtest: B-DP1 [133.478667] Dynamic subtest B-DP1: SUCCESS (1.061s) [133.500798] Starting dynamic subtest: C-DP1 [134.576249] Dynamic subtest C-DP1: SUCCESS (1.091s) [134.590586] Starting dynamic subtest: A-DP2 [135.482622] Dynamic subtest A-DP2: SUCCESS (0.902s) [135.495089] Starting dynamic subtest: B-DP2 [136.390396] Dynamic subtest B-DP2: SUCCESS (0.911s) [136.406399] Starting dynamic subtest: C-DP2 [137.292305] Dynamic subtest C-DP2: SUCCESS (0.899s) [137.295760] Subtest basic-flip-vs-dpms: SUCCESS (6.044s) [137.735315] [104/165] (872s left) kms_flip (basic-flip-vs-modeset) [138.016234] Starting subtest: basic-flip-vs-modeset [138.022699] Starting dynamic subtest: A-DP1 [139.075592] Dynamic subtest A-DP1: SUCCESS (1.050s) [139.092612] Starting dynamic subtest: B-DP1 [140.077878] Dynamic subtest B-DP1: SUCCESS (1.003s) [140.089151] Starting dynamic subtest: C-DP1 [141.076297] Dynamic subtest C-DP1: SUCCESS (0.992s) [141.093974] Starting dynamic subtest: A-DP2 [141.813265] Dynamic subtest A-DP2: SUCCESS (0.737s) [141.823872] Starting dynamic subtest: B-DP2 [142.686174] Dynamic subtest B-DP2: SUCCESS (0.867s) [142.695743] Starting dynamic subtest: C-DP2 [143.387284] Dynamic subtest C-DP2: SUCCESS (0.702s) [143.390383] Subtest basic-flip-vs-modeset: SUCCESS (5.373s) [143.835636] [105/165] (866s left) kms_flip (basic-flip-vs-wf_vblank) [144.118377] Starting subtest: basic-flip-vs-wf_vblank [144.121418] Starting dynamic subtest: A-DP1 [145.431562] Dynamic subtest A-DP1: SUCCESS (1.209s) [145.497689] Starting dynamic subtest: B-DP1 [146.433720] Dynamic subtest B-DP1: SUCCESS (1.107s) [146.444105] Starting dynamic subtest: C-DP1 [147.575786] Dynamic subtest C-DP1: SUCCESS (1.133s) [147.588054] Starting dynamic subtest: A-DP2 [148.619616] Dynamic subtest A-DP2: SUCCESS (1.045s) [148.632417] Starting dynamic subtest: B-DP2 [149.663669] Dynamic subtest B-DP2: SUCCESS (1.041s) [149.674407] Starting dynamic subtest: C-DP2 [150.709895] Dynamic subtest C-DP2: SUCCESS (1.046s) [150.713239] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.596s) [151.231401] [106/165] (859s left) kms_flip (basic-plain-flip) [151.516538] Starting subtest: basic-plain-flip [151.519643] Starting dynamic subtest: A-DP1 [152.453346] Dynamic subtest A-DP1: SUCCESS (0.939s) [152.465431] Starting dynamic subtest: B-DP1 [153.299087] Dynamic subtest B-DP1: SUCCESS (0.838s) [153.332469] Starting dynamic subtest: C-DP1 [154.316731] Dynamic subtest C-DP1: SUCCESS (0.917s) [154.383025] Starting dynamic subtest: A-DP2 [155.097026] Dynamic subtest A-DP2: SUCCESS (0.776s) [155.241664] Starting dynamic subtest: B-DP2 [155.770963] Dynamic subtest B-DP2: SUCCESS (0.771s) [155.783563] Starting dynamic subtest: C-DP2 [156.533175] Dynamic subtest C-DP2: SUCCESS (0.760s) [156.536513] Subtest basic-plain-flip: SUCCESS (5.024s) [157.067873] [107/165] (853s left) kms_force_connector_basic (force-connector-state) [157.189998] Starting subtest: force-connector-state [157.795448] Subtest force-connector-state: SUCCESS (0.601s) [158.748613] [108/165] (852s left) kms_force_connector_basic (force-edid) [158.870012] Starting subtest: force-edid [158.974398] Subtest force-edid: SUCCESS (0.105s) [159.498614] [109/165] (851s left) kms_force_connector_basic (force-load-detect) [159.617949] Starting subtest: force-load-detect [159.623442] Subtest force-load-detect: SKIP (0.000s) [159.934800] [110/165] (850s left) kms_force_connector_basic (prune-stale-modes) [160.066626] Starting subtest: prune-stale-modes [160.174236] Subtest prune-stale-modes: SUCCESS (0.111s) [160.697917] [111/165] (850s left) kms_frontbuffer_tracking (basic) [160.995128] Starting subtest: basic [163.827187] Subtest basic: SUCCESS (2.758s) [163.995996] [112/165] (846s left) kms_hdmi_inject (inject-audio) [164.220114] Starting subtest: inject-audio [164.395572] Subtest inject-audio: SUCCESS (0.176s) [165.069390] [113/165] (845s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24) [165.356487] Starting subtest: compare-crc-sanitycheck-xr24 [165.359756] Starting dynamic subtest: pipe-A-DP-1 [165.945290] Dynamic subtest pipe-A-DP-1: SUCCESS (0.586s) [165.958069] Starting dynamic subtest: pipe-B-DP-2 [166.410868] Dynamic subtest pipe-B-DP-2: SUCCESS (0.459s) [166.423882] Starting dynamic subtest: pipe-C-DP-1 [166.957242] Dynamic subtest pipe-C-DP-1: SUCCESS (0.543s) [166.961305] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.601s) [167.384547] [114/165] (843s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [167.699449] Starting subtest: compare-crc-sanitycheck-nv12 [167.702389] Starting dynamic subtest: pipe-A-DP-1 [168.334112] Dynamic subtest pipe-A-DP-1: SUCCESS (0.632s) [168.344309] Starting dynamic subtest: pipe-B-DP-2 [168.849059] Dynamic subtest pipe-B-DP-2: SUCCESS (0.510s) [168.862627] Starting dynamic subtest: pipe-C-DP-1 [168.869104] Dynamic subtest pipe-C-DP-1: SKIP (0.001s) [168.872177] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.155s) [169.234249] [115/165] (841s left) kms_pipe_crc_basic (hang-read-crc) [169.524420] Starting subtest: hang-read-crc [169.527224] Starting dynamic subtest: pipe-A-DP-1 [170.872812] Dynamic subtest pipe-A-DP-1: SUCCESS (1.344s) [170.892859] Starting dynamic subtest: pipe-B-DP-2 [172.060988] Dynamic subtest pipe-B-DP-2: SUCCESS (1.185s) [172.077885] Starting dynamic subtest: pipe-C-DP-1 [173.417941] Dynamic subtest pipe-C-DP-1: SUCCESS (1.347s) [173.422212] Subtest hang-read-crc: SUCCESS (3.892s) [173.798545] [116/165] (837s left) kms_pipe_crc_basic (nonblocking-crc) [174.105291] Starting subtest: nonblocking-crc [174.108072] Starting dynamic subtest: pipe-A-DP-1 [174.880648] Dynamic subtest pipe-A-DP-1: SUCCESS (0.771s) [174.894152] Starting dynamic subtest: pipe-B-DP-2 [175.535312] Dynamic subtest pipe-B-DP-2: SUCCESS (0.654s) [175.546890] Starting dynamic subtest: pipe-C-DP-1 [176.250165] Dynamic subtest pipe-C-DP-1: SUCCESS (0.711s) [176.253667] Subtest nonblocking-crc: SUCCESS (2.147s) [176.651149] [117/165] (834s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [176.939383] Starting subtest: nonblocking-crc-frame-sequence [176.942111] Starting dynamic subtest: pipe-A-DP-1 [177.730105] Dynamic subtest pipe-A-DP-1: SUCCESS (0.788s) [177.740085] Starting dynamic subtest: pipe-B-DP-2 [178.377808] Dynamic subtest pipe-B-DP-2: SUCCESS (0.644s) [178.388706] Starting dynamic subtest: pipe-C-DP-1 [179.110973] Dynamic subtest pipe-C-DP-1: SUCCESS (0.730s) [179.114149] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.173s) [179.520272] [118/165] (831s left) kms_pipe_crc_basic (read-crc) [179.819256] Starting subtest: read-crc [179.821993] Starting dynamic subtest: pipe-A-DP-1 [180.530612] Dynamic subtest pipe-A-DP-1: SUCCESS (0.710s) [180.544658] Starting dynamic subtest: pipe-B-DP-2 [181.126430] Dynamic subtest pipe-B-DP-2: SUCCESS (0.592s) [181.139640] Starting dynamic subtest: pipe-C-DP-1 [181.806931] Dynamic subtest pipe-C-DP-1: SUCCESS (0.676s) [181.810878] Subtest read-crc: SUCCESS (1.988s) [182.194667] [119/165] (828s left) kms_pipe_crc_basic (read-crc-frame-sequence) [182.503335] Starting subtest: read-crc-frame-sequence [182.506120] Starting dynamic subtest: pipe-A-DP-1 [183.195290] Dynamic subtest pipe-A-DP-1: SUCCESS (0.686s) [183.209690] Starting dynamic subtest: pipe-B-DP-2 [183.799662] Dynamic subtest pipe-B-DP-2: SUCCESS (0.604s) [183.812923] Starting dynamic subtest: pipe-C-DP-1 [184.477075] Dynamic subtest pipe-C-DP-1: SUCCESS (0.674s) [184.480437] Subtest read-crc-frame-sequence: SUCCESS (1.977s) [184.862116] [120/165] (826s left) kms_pm_backlight (basic-brightness) [185.165909] Subtest basic-brightness: SKIP (0.000s) [185.193910] [121/165] (826s left) kms_psr (primary_page_flip) [185.264231] Subtest primary_page_flip: SKIP (0.000s) [185.294388] [122/165] (825s left) kms_psr (cursor_plane_move) [185.365130] Subtest cursor_plane_move: SKIP (0.000s) [185.393852] [123/165] (825s left) kms_psr (sprite_plane_onoff) [185.464146] Subtest sprite_plane_onoff: SKIP (0.000s) [185.494333] [124/165] (825s left) kms_psr (primary_mmap_gtt) [185.566975] Subtest primary_mmap_gtt: SKIP (0.000s) [185.593881] [125/165] (825s left) kms_setmode (basic-clone-single-crtc) [185.660474] Starting subtest: basic-clone-single-crtc [185.843484] Subtest basic-clone-single-crtc: SKIP (0.179s) [186.240235] [126/165] (825s left) i915_pm_rpm (basic-pci-d3-state) [188.315632] Starting subtest: basic-pci-d3-state [189.413233] Subtest basic-pci-d3-state: SUCCESS (1.169s) [189.958729] [127/165] (821s left) i915_pm_rpm (basic-rte) [190.052704] Starting subtest: basic-rte [192.723741] Subtest basic-rte: SUCCESS (2.665s) [193.933092] [128/165] (817s left) i915_pm_rps (basic-api) [194.027555] Starting subtest: basic-api [194.030834] Subtest basic-api: SUCCESS (0.004s) [194.104791] [129/165] (817s left) prime_self_import (basic-llseek-bad) [194.191182] Starting subtest: basic-llseek-bad [194.197606] Subtest basic-llseek-bad: SUCCESS (0.004s) [194.314887] [130/165] (817s left) prime_self_import (basic-llseek-size) [194.400546] Starting subtest: basic-llseek-size [194.406960] Subtest basic-llseek-size: SUCCESS (0.002s) [194.514901] [131/165] (817s left) prime_self_import (basic-with_fd_dup) [194.581250] Starting subtest: basic-with_fd_dup [194.586945] Subtest basic-with_fd_dup: SUCCESS (0.003s) [194.702240] [132/165] (817s left) prime_self_import (basic-with_one_bo) [194.783291] Starting subtest: basic-with_one_bo [194.789017] Subtest basic-with_one_bo: SUCCESS (0.004s) [194.849568] [133/165] (817s left) prime_self_import (basic-with_one_bo_two_files) [194.918407] Starting subtest: basic-with_one_bo_two_files [194.924329] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [195.022148] [134/165] (816s left) prime_self_import (basic-with_two_bos) [195.105891] Starting subtest: basic-with_two_bos [195.112033] Subtest basic-with_two_bos: SUCCESS (0.005s) [195.192094] [135/165] (816s left) prime_vgem (basic-fence-flip) [195.277327] Starting subtest: basic-fence-flip [195.936554] Subtest basic-fence-flip: SUCCESS (0.659s) [196.057976] [136/165] (815s left) prime_vgem (basic-fence-mmap) [196.157605] Starting subtest: basic-fence-mmap [196.186606] Subtest basic-fence-mmap: SUCCESS (0.029s) [196.317877] [137/165] (815s left) prime_vgem (basic-fence-read) [196.402749] Starting subtest: basic-fence-read [196.450894] Subtest basic-fence-read: SUCCESS (0.048s) [196.572715] [138/165] (815s left) prime_vgem (basic-gtt) [196.689400] Starting subtest: basic-gtt [196.712675] Subtest basic-gtt: SUCCESS (0.024s) [196.793180] [139/165] (815s left) prime_vgem (basic-read) [196.878512] Starting subtest: basic-read [196.896949] Subtest basic-read: SUCCESS (0.021s) [197.007363] [140/165] (815s left) prime_vgem (basic-write) [197.122339] Starting subtest: basic-write [197.145835] Subtest basic-write: SUCCESS (0.024s) [197.227229] [141/165] (814s left) vgem_basic (setversion) [197.322486] Starting subtest: setversion [197.329966] Subtest setversion: SUCCESS (0.000s) [197.391157] [142/165] (814s left) vgem_basic (create) [197.487950] Starting subtest: create [197.491446] Subtest create: SUCCESS (0.000s) [197.565261] [143/165] (814s left) vgem_basic (debugfs) [197.654167] Starting subtest: debugfs [197.657212] Subtest debugfs: SUCCESS (0.000s) [197.708382] [144/165] (814s left) vgem_basic (dmabuf-export) [197.787867] Starting subtest: dmabuf-export [197.794072] Subtest dmabuf-export: SUCCESS (0.002s) [197.902689] [145/165] (814s left) vgem_basic (dmabuf-fence) [198.006130] Starting subtest: dmabuf-fence [198.009477] Subtest dmabuf-fence: SUCCESS (0.001s) [198.061116] [146/165] (814s left) vgem_basic (dmabuf-fence-before) [198.140070] Starting subtest: dmabuf-fence-before [198.143272] Subtest dmabuf-fence-before: SUCCESS (0.001s) [198.191671] [147/165] (814s left) vgem_basic (dmabuf-mmap) [198.271977] Starting subtest: dmabuf-mmap [198.293783] Subtest dmabuf-mmap: SUCCESS (0.024s) [198.352641] [148/165] (814s left) vgem_basic (mmap) [198.440567] Starting subtest: mmap [198.447874] Subtest mmap: SUCCESS (0.009s) [198.489263] [149/165] (813s left) vgem_basic (second-client) [198.571867] Starting subtest: second-client [198.605851] Subtest second-client: SUCCESS (0.032s) [198.677886] [150/165] (813s left) vgem_basic (sysfs) [198.772103] Starting subtest: sysfs [198.785644] Subtest sysfs: SUCCESS (0.001s) [198.846427] [151/165] (813s left) core_hotunplug (unbind-rebind) [198.969692] Starting subtest: unbind-rebind [202.423884] Subtest unbind-rebind: SUCCESS (3.455s) [202.452053] [152/165] (810s left) vgem_basic (unload) [202.531385] Starting subtest: unload [231.491315] Subtest unload: SUCCESS (28.959s) [231.637124] [153/165] (780s left) i915_module_load (reload) [231.719943] Starting subtest: reload [234.686236] Subtest reload: SUCCESS (2.968s) [234.707644] [154/165] (777s left) gem_lmem_swapping (basic) [234.790205] Subtest basic: SKIP (0.000s) [234.827397] [155/165] (777s left) gem_lmem_swapping (parallel-random-engines) [234.901299] Subtest parallel-random-engines: SKIP (0.000s) [234.932353] [156/165] (777s left) gem_lmem_swapping (random-engines) [235.001655] Subtest random-engines: SKIP (0.000s) [235.032302] [157/165] (777s left) gem_lmem_swapping (verify-random) [235.107081] Subtest verify-random: SKIP (0.000s) [235.132419] [158/165] (777s left) i915_pm_rpm (module-reload) [237.408638] Starting subtest: module-reload [248.443709] Subtest module-reload: SUCCESS (11.044s) [248.482081] [159/165] (764s left) i915_selftest (live) [248.590283] Starting subtest: live [248.593555] Starting dynamic subtest: sanitycheck [249.271151] Dynamic subtest sanitycheck: SUCCESS (0.680s) [249.280742] Starting dynamic subtest: uncore [249.934358] Dynamic subtest uncore: SUCCESS (0.661s) [249.948616] Starting dynamic subtest: workarounds [250.825195] Dynamic subtest workarounds: SUCCESS (0.886s) [250.834637] Starting dynamic subtest: gt_engines [252.051384] Dynamic subtest gt_engines: SUCCESS (1.223s) [252.064309] Starting dynamic subtest: gt_timelines [263.458178] Dynamic subtest gt_timelines: SUCCESS (11.408s) [263.469314] Starting dynamic subtest: gt_contexts [264.286964] Dynamic subtest gt_contexts: SUCCESS (0.826s) [264.295924] Starting dynamic subtest: gt_lrc [268.001894] Dynamic subtest gt_lrc: SUCCESS (3.713s) [268.012308] Starting dynamic subtest: gt_mocs [268.777946] Dynamic subtest gt_mocs: SUCCESS (0.774s) [268.786871] Starting dynamic subtest: gt_pm [275.345819] Dynamic subtest gt_pm: SUCCESS (6.566s) [275.355793] Starting dynamic subtest: gt_heartbeat [276.136247] Dynamic subtest gt_heartbeat: SUCCESS (0.787s) [276.145174] Starting dynamic subtest: gt_tlb [277.980720] Dynamic subtest gt_tlb: SUCCESS (1.784s) [278.048023] Starting dynamic subtest: requests [286.009294] Dynamic subtest requests: SUCCESS (8.087s) [286.020568] Starting dynamic subtest: migrate [289.501966] Dynamic subtest migrate: SUCCESS (3.491s) [289.510837] Starting dynamic subtest: active [290.224268] Dynamic subtest active: SUCCESS (0.718s) [290.234706] Starting dynamic subtest: objects [291.955967] Dynamic subtest objects: SUCCESS (1.732s) [291.965457] Starting dynamic subtest: mman [296.512914] Dynamic subtest mman: SUCCESS (4.555s) [296.523416] Starting dynamic subtest: dmabuf [297.255051] Dynamic subtest dmabuf: SUCCESS (0.740s) [297.263917] Starting dynamic subtest: vma [297.942015] Dynamic subtest vma: SUCCESS (0.685s) [297.951114] Starting dynamic subtest: coherency [300.374071] Dynamic subtest coherency: SUCCESS (2.430s) [300.383108] Starting dynamic subtest: gtt [308.289978] Dynamic subtest gtt: SUCCESS (7.914s) [308.298948] Starting dynamic subtest: gem [309.167032] Dynamic subtest gem: SUCCESS (0.875s) [309.176718] Starting dynamic subtest: evict [311.501898] Dynamic subtest evict: SUCCESS (2.333s) [311.510348] Starting dynamic subtest: hugepages [318.634220] Dynamic subtest hugepages: SUCCESS (7.131s) [318.644808] Starting dynamic subtest: gem_contexts [335.139131] Dynamic subtest gem_contexts: SUCCESS (16.503s) [335.149550] Starting dynamic subtest: client [335.891669] Dynamic subtest client: SUCCESS (0.750s) [335.902649] Starting dynamic subtest: gem_migrate [336.536232] Dynamic subtest gem_migrate: SUCCESS (0.641s) [336.546082] Starting dynamic subtest: reset [338.022177] Dynamic subtest reset: SUCCESS (1.486s) [338.031957] Starting dynamic subtest: memory_region [338.710271] Dynamic subtest memory_region: SUCCESS (0.686s) [338.719979] Starting dynamic subtest: hangcheck [367.946945] Dynamic subtest hangcheck: SUCCESS (29.235s) [367.956872] Starting dynamic subtest: execlists [381.027165] Dynamic subtest execlists: SUCCESS (13.078s) [381.039487] Starting dynamic subtest: ring_submission [381.729212] Dynamic subtest ring_submission: SUCCESS (0.700s) [381.738900] Starting dynamic subtest: perf [382.463419] Dynamic subtest perf: SUCCESS (0.732s) [382.477535] Starting dynamic subtest: slpc [383.160154] Dynamic subtest slpc: SUCCESS (0.695s) [383.169337] Starting dynamic subtest: guc [383.850320] Dynamic subtest guc: SUCCESS (0.686s) [383.863167] Starting dynamic subtest: guc_multi_lrc [384.538132] Dynamic subtest guc_multi_lrc: SUCCESS (0.688s) [384.547495] Starting dynamic subtest: guc_hang [385.223069] Dynamic subtest guc_hang: SUCCESS (0.683s) [385.234425] Starting dynamic subtest: late_gt_pm [385.941105] Dynamic subtest late_gt_pm: SUCCESS (0.716s) [385.944424] Subtest live: SUCCESS (137.352s) [385.967988] [160/165] (626s left) dmabuf (all-tests) [386.051206] Starting subtest: all-tests [386.054312] Starting dynamic subtest: sanitycheck [386.124412] Dynamic subtest sanitycheck: SUCCESS (0.074s) [386.143700] Starting dynamic subtest: dma_fence [386.311417] Dynamic subtest dma_fence: SUCCESS (0.187s) [386.322255] Starting dynamic subtest: dma_fence_chain [401.112034] Dynamic subtest dma_fence_chain: SUCCESS (14.799s) [401.130179] Starting dynamic subtest: dma_fence_unwrap [401.188038] Dynamic subtest dma_fence_unwrap: SUCCESS (0.073s) [401.206330] Starting dynamic subtest: dma_resv [401.263173] Dynamic subtest dma_resv: SUCCESS (0.072s) [401.267146] Subtest all-tests: SUCCESS (15.218s) [401.305998] [161/165] (611s left) i915_suspend (basic-s2idle-without-i915) [401.390481] Starting subtest: basic-s2idle-without-i915 [419.998596] Subtest basic-s2idle-without-i915: SUCCESS (3.606s) [423.627912] [162/165] (607s left) i915_suspend (basic-s3-without-i915) [423.700640] Starting subtest: basic-s3-without-i915 [442.669581] Subtest basic-s3-without-i915: SUCCESS (3.121s) [446.327043] [163/165] (603s left) gem_exec_suspend (basic-s0) [446.433861] Starting subtest: basic-S0 [446.437241] Starting dynamic subtest: smem [465.157198] Dynamic subtest smem: SUCCESS (2.946s) [465.160513] Subtest basic-S0: SUCCESS (2.948s) [470.354841] [164/165] (600s left) gem_exec_suspend (basic-s3) [470.449153] Starting subtest: basic-S3 [470.453755] Starting dynamic subtest: smem [489.756426] Dynamic subtest smem: SUCCESS (3.545s) [489.759715] Subtest basic-S3: SUCCESS (3.547s) [492.942273] [165/165] (596s left) kms_pipe_crc_basic (suspend-read-crc) [493.243346] Starting subtest: suspend-read-crc [493.246681] Starting dynamic subtest: pipe-A-DP-1 [512.748723] Dynamic subtest pipe-A-DP-1: SUCCESS (3.116s) [512.762167] Starting dynamic subtest: pipe-B-DP-2 [531.690488] Dynamic subtest pipe-B-DP-2: SUCCESS (2.690s) [531.702245] Starting dynamic subtest: pipe-C-DP-1 [551.767688] Dynamic subtest pipe-C-DP-1: SUCCESS (2.960s) [551.770993] Subtest suspend-read-crc: SUCCESS (8.774s) [556.132477] Closing watchdogs Done.