[39.190158] Initializing watchdogs
[39.190209]   /dev/watchdog0
[39.196077] [001/164] (960s left) i915_module_load (load)
[39.236066] Starting subtest: load
[40.543425] Subtest load: SUCCESS (1.307s)
[40.556190] [002/164] (959s left) core_auth (basic-auth)
[40.617580] Starting subtest: basic-auth
[40.619535] Subtest basic-auth: SUCCESS (0.000s)
[40.670645] [003/164] (959s left) debugfs_test (read_all_entries)
[40.710713] Starting subtest: read_all_entries
[40.762283] Subtest read_all_entries: SUCCESS (0.050s)
[40.882720] [004/164] (958s left) debugfs_test (basic-hwmon)
[40.960436] Starting subtest: basic-hwmon
[40.963606] Subtest basic-hwmon: SKIP (0.000s)
[41.078616] [005/164] (958s left) fbdev (eof)
[41.160307] Starting subtest: eof
[41.161785] Subtest eof: SUCCESS (0.000s)
[41.205866] [006/164] (958s left) fbdev (info)
[41.245355] Starting subtest: info
[41.247049] Subtest info: SUCCESS (0.000s)
[41.311955] [007/164] (958s left) fbdev (nullptr)
[41.359930] Starting subtest: nullptr
[41.361672] Subtest nullptr: SUCCESS (0.000s)
[41.405439] [008/164] (958s left) fbdev (read)
[41.460045] Starting subtest: read
[41.677851] Subtest read: SUCCESS (0.218s)
[41.720939] [009/164] (958s left) fbdev (write)
[41.759948] Starting subtest: write
[41.870829] Subtest write: SUCCESS (0.111s)
[41.904735] [010/164] (957s left) gem_basic (bad-close)
[41.943404] Starting subtest: bad-close
[41.946730] Subtest bad-close: SUCCESS (0.000s)
[41.990050] [011/164] (957s left) gem_basic (create-close)
[42.031710] Starting subtest: create-close
[42.035009] Subtest create-close: SUCCESS (0.000s)
[42.093148] [012/164] (957s left) gem_basic (create-fd-close)
[42.135217] Starting subtest: create-fd-close
[42.138567] Subtest create-fd-close: SUCCESS (0.000s)
[42.219746] [013/164] (957s left) gem_busy (busy@all-engines)
[42.310895] Starting subtest: busy
[42.312494] Starting dynamic subtest: all-engines
[42.333522] Dynamic subtest all-engines: SUCCESS (0.022s)
[42.335218] Subtest busy: SUCCESS (0.022s)
[42.698680] [014/164] (957s left) gem_close_race (basic-process)
[42.740390] Starting subtest: basic-process
[42.803029] Subtest basic-process: SUCCESS (0.062s)
[43.012411] [015/164] (956s left) gem_close_race (basic-threads)
[43.094943] Starting subtest: basic-threads
[44.308068] Subtest basic-threads: SUCCESS (1.212s)
[44.519725] [016/164] (955s left) gem_ctx_create (basic)
[44.574752] Starting subtest: basic
[44.576148] Subtest basic: SUCCESS (0.000s)
[44.757035] [017/164] (955s left) gem_ctx_create (basic-files)
[44.811377] Starting subtest: basic-files
[46.822061] Subtest basic-files: SUCCESS (2.010s)
[47.066305] [018/164] (952s left) gem_ctx_exec (basic)
[47.108812] Starting subtest: basic
[47.111853] Subtest basic: SUCCESS (0.003s)
[47.210896] [019/164] (952s left) gem_exec_basic (basic)
[47.273754] Starting subtest: basic
[47.275137] Starting dynamic subtest: rcs0-smem
[47.276722] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[47.281945] Starting dynamic subtest: bcs0-smem
[47.283577] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[47.288815] Starting dynamic subtest: vcs0-smem
[47.290506] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[47.295466] Starting dynamic subtest: vecs0-smem
[47.297185] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[47.298884] Subtest basic: SUCCESS (0.003s)
[47.499647] [020/164] (952s left) gem_exec_create (basic)
[47.554753] Starting subtest: basic
[47.556519] Starting dynamic subtest: smem
[49.607749] Dynamic subtest smem: SUCCESS (2.053s)
[49.609484] Subtest basic: SUCCESS (2.053s)
[49.795768] [021/164] (950s left) gem_exec_fence (basic-busy)
[49.957832] Starting subtest: basic-busy
[49.959763] Starting dynamic subtest: rcs0
[49.992941] Dynamic subtest rcs0: SUCCESS (0.034s)
[50.015287] Starting dynamic subtest: bcs0
[50.034930] Dynamic subtest bcs0: SUCCESS (0.041s)
[50.056398] Starting dynamic subtest: vcs0
[50.074405] Dynamic subtest vcs0: SUCCESS (0.040s)
[50.090058] Starting dynamic subtest: vecs0
[50.112448] Dynamic subtest vecs0: SUCCESS (0.038s)
[50.114679] Subtest basic-busy: SUCCESS (0.154s)
[50.646203] [022/164] (949s left) gem_exec_fence (basic-wait)
[50.835644] Starting subtest: basic-wait
[50.838098] Starting dynamic subtest: rcs0
[50.875265] Dynamic subtest rcs0: SUCCESS (0.042s)
[50.898786] Starting dynamic subtest: bcs0
[50.918240] Dynamic subtest bcs0: SUCCESS (0.043s)
[50.943459] Starting dynamic subtest: vcs0
[50.959954] Dynamic subtest vcs0: SUCCESS (0.042s)
[50.982461] Starting dynamic subtest: vecs0
[50.995122] Dynamic subtest vecs0: SUCCESS (0.035s)
[50.997089] Subtest basic-wait: SUCCESS (0.163s)
[51.582611] [023/164] (948s left) gem_exec_fence (basic-await)
[51.753776] Starting subtest: basic-await
[51.755393] Starting dynamic subtest: rcs0
[51.823223] Dynamic subtest rcs0: SUCCESS (0.069s)
[51.833918] Starting dynamic subtest: bcs0
[51.904130] Dynamic subtest bcs0: SUCCESS (0.081s)
[51.913058] Starting dynamic subtest: vcs0
[51.980542] Dynamic subtest vcs0: SUCCESS (0.076s)
[51.989892] Starting dynamic subtest: vecs0
[52.063873] Dynamic subtest vecs0: SUCCESS (0.082s)
[52.066781] Subtest basic-await: SUCCESS (0.309s)
[52.632293] [024/164] (947s left) gem_exec_fence (nb-await)
[52.785642] Starting subtest: nb-await
[52.787191] Starting dynamic subtest: rcs0
[52.842054] Dynamic subtest rcs0: SUCCESS (0.056s)
[52.864580] Starting dynamic subtest: bcs0
[52.913497] Dynamic subtest bcs0: SUCCESS (0.071s)
[52.923239] Starting dynamic subtest: vcs0
[52.973327] Dynamic subtest vcs0: SUCCESS (0.060s)
[52.984434] Starting dynamic subtest: vecs0
[53.033522] Dynamic subtest vecs0: SUCCESS (0.059s)
[53.036131] Subtest nb-await: SUCCESS (0.247s)
[53.533309] [025/164] (946s left) gem_exec_gttfill (basic)
[53.576315] Starting subtest: basic
[58.434939] Subtest basic: SUCCESS (4.859s)
[58.588690] [026/164] (941s left) gem_exec_parallel (engines)
[58.680451] Starting subtest: engines
[58.682043] Starting dynamic subtest: basic
[60.224336] Dynamic subtest basic: SUCCESS (1.544s)
[60.230579] Starting dynamic subtest: contexts
[62.578643] Dynamic subtest contexts: SUCCESS (2.354s)
[62.584918] Starting dynamic subtest: fds
[64.808730] Dynamic subtest fds: SUCCESS (2.230s)
[64.814956] Starting dynamic subtest: userptr
[66.869177] Dynamic subtest userptr: SUCCESS (2.060s)
[66.870834] Subtest engines: SUCCESS (8.189s)
[67.086928] [027/164] (933s left) gem_exec_store (basic)
[67.170067] Starting subtest: basic
[67.221140] Subtest basic: SUCCESS (0.051s)
[67.392163] [028/164] (932s left) gem_flink_basic (bad-flink)
[67.437545] Starting subtest: bad-flink
[67.439137] Subtest bad-flink: SUCCESS (0.000s)
[67.498606] [029/164] (932s left) gem_flink_basic (bad-open)
[67.572940] Starting subtest: bad-open
[67.574647] Subtest bad-open: SUCCESS (0.000s)
[67.625569] [030/164] (932s left) gem_flink_basic (basic)
[67.667165] Starting subtest: basic
[67.668831] Subtest basic: SUCCESS (0.000s)
[67.772087] [031/164] (932s left) gem_flink_basic (double-flink)
[67.818033] Starting subtest: double-flink
[67.819829] Subtest double-flink: SUCCESS (0.000s)
[67.907430] [032/164] (932s left) gem_flink_basic (flink-lifetime)
[67.972656] Starting subtest: flink-lifetime
[67.974379] Subtest flink-lifetime: SUCCESS (0.001s)
[68.038740] [033/164] (932s left) gem_huc_copy (huc-copy)
[68.114434] Starting subtest: huc-copy
[68.117731] Subtest huc-copy: SKIP (0.000s)
[68.237443] [034/164] (932s left) gem_linear_blits (basic)
[68.346933] Starting subtest: basic
[68.351488] Subtest basic: SUCCESS (0.004s)
[68.481120] [035/164] (932s left) gem_mmap (basic)
[68.612321] Starting subtest: basic
[68.620497] Subtest basic: SUCCESS (0.000s)
[68.714851] [036/164] (931s left) gem_mmap_gtt (basic)
[68.753186] Starting subtest: basic
[68.754877] Subtest basic: SUCCESS (0.000s)
[68.804314] [037/164] (931s left) gem_render_linear_blits (basic)
[68.870340] Starting subtest: basic
[68.889298] Subtest basic: SUCCESS (0.020s)
[68.917101] [038/164] (931s left) gem_render_tiled_blits (basic)
[68.954548] Starting subtest: basic
[68.977580] Subtest basic: SUCCESS (0.023s)
[69.018101] [039/164] (931s left) gem_ringfill (basic-all)
[69.280633] Starting subtest: basic-all
[70.437127] Subtest basic-all: SUCCESS (1.157s)
[70.568419] [040/164] (930s left) gem_softpin (allocator-basic)
[70.636779] Starting subtest: allocator-basic
[70.719250] Subtest allocator-basic: SUCCESS (0.083s)
[70.849222] [041/164] (929s left) gem_softpin (allocator-basic-reserve)
[70.927263] Starting subtest: allocator-basic-reserve
[70.984593] Subtest allocator-basic-reserve: SUCCESS (0.059s)
[71.093169] [042/164] (929s left) gem_softpin (safe-alignment)
[71.178592] Starting subtest: safe-alignment
[71.185478] Subtest safe-alignment: SUCCESS (0.007s)
[71.297038] [043/164] (929s left) gem_sync (basic-all)
[71.361541] Starting subtest: basic-all
[73.466713] Subtest basic-all: SUCCESS (2.112s)
[73.645837] [044/164] (927s left) gem_sync (basic-each)
[73.700554] Starting subtest: basic-each
[75.778612] Subtest basic-each: SUCCESS (2.083s)
[75.984719] [045/164] (924s left) gem_tiled_blits (basic)
[76.126938] Starting subtest: basic
[76.138451] Subtest basic: SUCCESS (0.011s)
[76.282856] [046/164] (924s left) gem_tiled_fence_blits (basic)
[76.470796] Starting subtest: basic
[76.477385] Subtest basic: SUCCESS (0.007s)
[76.597215] [047/164] (924s left) gem_tiled_pread_basic
[76.895758] [048/164] (924s left) gem_wait (busy@all-engines)
[76.951324] Starting subtest: busy
[76.952981] Starting dynamic subtest: all-engines
[77.476789] Dynamic subtest all-engines: SUCCESS (0.525s)
[77.478233] Subtest busy: SUCCESS (0.525s)
[77.674228] [049/164] (923s left) gem_wait (wait@all-engines)
[77.720181] Starting subtest: wait
[77.721904] Starting dynamic subtest: all-engines
[78.772295] Dynamic subtest all-engines: SUCCESS (1.050s)
[78.775085] Subtest wait: SUCCESS (1.051s)
[78.957902] [050/164] (921s left) i915_getparams_basic (basic-eu-total)
[78.994359] Starting subtest: basic-eu-total
[78.997190] Subtest basic-eu-total: SUCCESS (0.000s)
[79.076714] [051/164] (921s left) i915_getparams_basic (basic-subslice-total)
[79.159196] Starting subtest: basic-subslice-total
[79.162334] Subtest basic-subslice-total: SUCCESS (0.000s)
[79.205106] [052/164] (921s left) i915_hangman (error-state-basic)
[79.254587] Starting subtest: error-state-basic
[79.258932] Subtest error-state-basic: SUCCESS (0.005s)
[79.330155] [053/164] (921s left) i915_pciid
[79.456819] [054/164] (921s left) kms_addfb_basic (addfb25-4-tiled)
[79.551354] Starting subtest: addfb25-4-tiled
[79.552885] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[79.638509] [055/164] (921s left) kms_addfb_basic (addfb25-bad-modifier)
[79.710841] Starting subtest: addfb25-bad-modifier
[79.712386] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[79.828598] [056/164] (921s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[79.897805] Starting subtest: addfb25-framebuffer-vs-set-tiling
[79.899474] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[80.036822] [057/164] (921s left) kms_addfb_basic (addfb25-modifier-no-flag)
[80.105768] Starting subtest: addfb25-modifier-no-flag
[80.107477] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[80.249115] [058/164] (920s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[80.288466] Starting subtest: addfb25-x-tiled-legacy
[80.290109] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[80.423662] [059/164] (920s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[80.471049] Starting subtest: addfb25-x-tiled-mismatch-legacy
[80.472603] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[80.605119] [060/164] (920s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[80.731186] Starting subtest: addfb25-yf-tiled-legacy
[80.732730] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[80.824033] [061/164] (920s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[80.920192] Starting subtest: addfb25-y-tiled-legacy
[80.921652] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[81.007508] [062/164] (920s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[81.108434] Starting subtest: addfb25-y-tiled-small-legacy
[81.109753] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[81.214073] [063/164] (920s left) kms_addfb_basic (bad-pitch-0)
[81.263649] Starting subtest: bad-pitch-0
[81.265249] Subtest bad-pitch-0: SUCCESS (0.000s)
[81.380255] [064/164] (919s left) kms_addfb_basic (bad-pitch-1024)
[81.426058] Starting subtest: bad-pitch-1024
[81.427649] Subtest bad-pitch-1024: SUCCESS (0.000s)
[81.553291] [065/164] (919s left) kms_addfb_basic (bad-pitch-128)
[81.629268] Starting subtest: bad-pitch-128
[81.630812] Subtest bad-pitch-128: SUCCESS (0.000s)
[81.767202] [066/164] (919s left) kms_addfb_basic (bad-pitch-256)
[81.805324] Starting subtest: bad-pitch-256
[81.806876] Subtest bad-pitch-256: SUCCESS (0.000s)
[81.930946] [067/164] (919s left) kms_addfb_basic (bad-pitch-32)
[81.977150] Starting subtest: bad-pitch-32
[81.978721] Subtest bad-pitch-32: SUCCESS (0.000s)
[82.120939] [068/164] (919s left) kms_addfb_basic (bad-pitch-63)
[82.158223] Starting subtest: bad-pitch-63
[82.159761] Subtest bad-pitch-63: SUCCESS (0.000s)
[82.331803] [069/164] (919s left) kms_addfb_basic (bad-pitch-65536)
[82.411310] Starting subtest: bad-pitch-65536
[82.413159] Subtest bad-pitch-65536: SUCCESS (0.000s)
[82.558204] [070/164] (918s left) kms_addfb_basic (bad-pitch-999)
[82.634272] Starting subtest: bad-pitch-999
[82.635820] Subtest bad-pitch-999: SUCCESS (0.000s)
[82.773852] [071/164] (918s left) kms_addfb_basic (basic)
[82.825135] Starting subtest: basic
[82.826694] Subtest basic: SUCCESS (0.000s)
[82.984193] [072/164] (918s left) kms_addfb_basic (basic-x-tiled-legacy)
[83.027408] Starting subtest: basic-x-tiled-legacy
[83.028865] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[83.175816] [073/164] (918s left) kms_addfb_basic (basic-y-tiled-legacy)
[83.223350] Starting subtest: basic-y-tiled-legacy
[83.224793] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[83.388858] [074/164] (918s left) kms_addfb_basic (bo-too-small)
[83.487198] Starting subtest: bo-too-small
[83.488723] Subtest bo-too-small: SUCCESS (0.000s)
[83.570521] [075/164] (918s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[83.667872] Starting subtest: bo-too-small-due-to-tiling
[83.669508] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[83.794526] [076/164] (917s left) kms_addfb_basic (clobberred-modifier)
[83.843513] Starting subtest: clobberred-modifier
[83.845062] Subtest clobberred-modifier: SUCCESS (0.000s)
[83.967513] [077/164] (917s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[84.038299] Starting subtest: framebuffer-vs-set-tiling
[84.039719] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[84.216508] [078/164] (917s left) kms_addfb_basic (invalid-get-prop)
[84.267403] Starting subtest: invalid-get-prop
[84.268928] Subtest invalid-get-prop: SUCCESS (0.000s)
[84.407147] [079/164] (917s left) kms_addfb_basic (invalid-get-prop-any)
[84.454741] Starting subtest: invalid-get-prop-any
[84.456284] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[84.584965] [080/164] (917s left) kms_addfb_basic (invalid-set-prop)
[84.630341] Starting subtest: invalid-set-prop
[84.631788] Subtest invalid-set-prop: SUCCESS (0.000s)
[84.769226] [081/164] (917s left) kms_addfb_basic (invalid-set-prop-any)
[84.839911] Starting subtest: invalid-set-prop-any
[84.841373] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[84.964565] [082/164] (916s left) kms_addfb_basic (no-handle)
[85.009931] Starting subtest: no-handle
[85.011494] Subtest no-handle: SUCCESS (0.000s)
[85.130959] [083/164] (916s left) kms_addfb_basic (size-max)
[85.243238] Starting subtest: size-max
[85.245084] Subtest size-max: SUCCESS (0.000s)
[85.339088] [084/164] (916s left) kms_addfb_basic (small-bo)
[85.461153] Starting subtest: small-bo
[85.462590] Subtest small-bo: SUCCESS (0.000s)
[85.556963] [085/164] (916s left) kms_addfb_basic (tile-pitch-mismatch)
[85.633444] Starting subtest: tile-pitch-mismatch
[85.634975] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[85.770244] [086/164] (916s left) kms_addfb_basic (too-high)
[85.867923] Starting subtest: too-high
[85.869325] Subtest too-high: SUCCESS (0.000s)
[85.951744] [087/164] (916s left) kms_addfb_basic (too-wide)
[86.071728] Starting subtest: too-wide
[86.073294] Subtest too-wide: SUCCESS (0.000s)
[86.169603] [088/164] (915s left) kms_addfb_basic (unused-handle)
[86.247228] Starting subtest: unused-handle
[86.248767] Subtest unused-handle: SUCCESS (0.000s)
[86.387934] [089/164] (915s left) kms_addfb_basic (unused-modifier)
[86.437127] Starting subtest: unused-modifier
[86.438658] Subtest unused-modifier: SUCCESS (0.000s)
[86.570423] [090/164] (915s left) kms_addfb_basic (unused-offsets)
[86.647584] Starting subtest: unused-offsets
[86.649110] Subtest unused-offsets: SUCCESS (0.000s)
[86.785853] [091/164] (915s left) kms_addfb_basic (unused-pitches)
[86.861230] Starting subtest: unused-pitches
[86.862767] Subtest unused-pitches: SUCCESS (0.000s)
[87.009671] [092/164] (915s left) kms_busy (basic)
[87.142977] Starting subtest: basic
[87.144591] Starting dynamic subtest: flip
[87.665020] Dynamic subtest flip: SUCCESS (0.520s)
[87.671849] Starting dynamic subtest: modeset
[88.080607] Dynamic subtest modeset: SUCCESS (0.417s)
[88.082242] Subtest basic: SUCCESS (0.937s)
[88.199932] [093/164] (913s left) kms_prop_blob (basic)
[88.245404] Starting subtest: basic
[88.247045] Subtest basic: SUCCESS (0.000s)
[88.297550] [094/164] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[88.388252] Starting subtest: basic-busy-flip-before-cursor-atomic
[88.391313] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[88.454493] [095/164] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[88.548150] Starting subtest: basic-busy-flip-before-cursor-legacy
[88.551072] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[88.601256] [096/164] (913s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[88.710389] Starting subtest: basic-flip-after-cursor-atomic
[89.620444] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.910s)
[89.722586] [097/164] (912s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[89.830281] Starting subtest: basic-flip-after-cursor-legacy
[90.761740] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.933s)
[90.851958] [098/164] (911s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[90.943097] Starting subtest: basic-flip-after-cursor-varying-size
[91.840337] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.899s)
[91.943173] [099/164] (910s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[92.032532] Starting subtest: basic-flip-before-cursor-atomic
[92.931152] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.900s)
[93.035180] [100/164] (909s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[93.121780] Starting subtest: basic-flip-before-cursor-legacy
[94.039546] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.920s)
[94.145143] [101/164] (908s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[94.233590] Starting subtest: basic-flip-before-cursor-varying-size
[95.132407] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.900s)
[95.279146] [102/164] (907s left) kms_flip (basic-flip-vs-dpms)
[95.363485] Starting subtest: basic-flip-vs-dpms
[95.365382] Starting dynamic subtest: A-HDMI-A1
[96.179714] Dynamic subtest A-HDMI-A1: SUCCESS (0.816s)
[96.186295] Starting dynamic subtest: B-HDMI-A1
[96.989288] Dynamic subtest B-HDMI-A1: SUCCESS (0.807s)
[96.996180] Starting dynamic subtest: C-HDMI-A1
[97.778315] Dynamic subtest C-HDMI-A1: SUCCESS (0.792s)
[97.779754] Subtest basic-flip-vs-dpms: SUCCESS (2.419s)
[97.872535] [103/164] (904s left) kms_flip (basic-flip-vs-modeset)
[97.951900] Starting subtest: basic-flip-vs-modeset
[97.953393] Starting dynamic subtest: A-HDMI-A1
[98.830550] Dynamic subtest A-HDMI-A1: SUCCESS (0.875s)
[98.837366] Starting dynamic subtest: B-HDMI-A1
[99.588418] Dynamic subtest B-HDMI-A1: SUCCESS (0.759s)
[99.594866] Starting dynamic subtest: C-HDMI-A1
[100.350392] Dynamic subtest C-HDMI-A1: SUCCESS (0.762s)
[100.351948] Subtest basic-flip-vs-modeset: SUCCESS (2.401s)
[100.467882] [104/164] (901s left) kms_flip (basic-flip-vs-wf_vblank)
[100.560662] Starting subtest: basic-flip-vs-wf_vblank
[100.564663] Starting dynamic subtest: A-HDMI-A1
[101.655113] Dynamic subtest A-HDMI-A1: SUCCESS (1.093s)
[101.662162] Starting dynamic subtest: B-HDMI-A1
[102.722091] Dynamic subtest B-HDMI-A1: SUCCESS (1.066s)
[102.729132] Starting dynamic subtest: C-HDMI-A1
[103.791405] Dynamic subtest C-HDMI-A1: SUCCESS (1.069s)
[103.792915] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.234s)
[103.929388] [105/164] (898s left) kms_flip (basic-plain-flip)
[104.004669] Starting subtest: basic-plain-flip
[104.006169] Starting dynamic subtest: A-HDMI-A1
[104.813769] Dynamic subtest A-HDMI-A1: SUCCESS (0.810s)
[104.821369] Starting dynamic subtest: B-HDMI-A1
[105.600413] Dynamic subtest B-HDMI-A1: SUCCESS (0.786s)
[105.607472] Starting dynamic subtest: C-HDMI-A1
[106.384756] Dynamic subtest C-HDMI-A1: SUCCESS (0.784s)
[106.386221] Subtest basic-plain-flip: SUCCESS (2.384s)
[106.520950] [106/164] (895s left) kms_force_connector_basic (force-connector-state)
[106.659517] Starting subtest: force-connector-state
[106.926640] Subtest force-connector-state: SUCCESS (0.267s)
[107.357355] [107/164] (895s left) kms_force_connector_basic (force-edid)
[107.527596] Starting subtest: force-edid
[107.659280] Subtest force-edid: SUCCESS (0.133s)
[107.851199] [108/164] (894s left) kms_force_connector_basic (force-load-detect)
[107.990538] Starting subtest: force-load-detect
[107.993467] Subtest force-load-detect: SKIP (0.000s)
[108.183272] [109/164] (894s left) kms_force_connector_basic (prune-stale-modes)
[108.328644] Starting subtest: prune-stale-modes
[108.462355] Subtest prune-stale-modes: SUCCESS (0.134s)
[108.671414] [110/164] (893s left) kms_frontbuffer_tracking (basic)
[108.807395] Starting subtest: basic
[111.201279] Subtest basic: SUCCESS (2.397s)
[111.325087] [111/164] (891s left) kms_hdmi_inject (inject-audio)
[111.389479] Starting subtest: inject-audio
[111.502481] Subtest inject-audio: SUCCESS (0.113s)
[111.699088] [112/164] (890s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[111.797758] Starting subtest: compare-crc-sanitycheck-xr24
[111.799406] Starting dynamic subtest: pipe-A-HDMI-A-1
[112.110280] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.313s)
[112.116702] Starting dynamic subtest: pipe-B-HDMI-A-1
[112.426317] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.314s)
[112.434447] Starting dynamic subtest: pipe-C-HDMI-A-1
[112.743148] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.316s)
[112.744750] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.946s)
[112.851203] [113/164] (889s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[112.941182] Starting subtest: compare-crc-sanitycheck-nv12
[112.942654] Starting dynamic subtest: pipe-A-HDMI-A-1
[113.324988] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.383s)
[113.332890] Starting dynamic subtest: pipe-B-HDMI-A-1
[113.673244] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.346s)
[113.681434] Starting dynamic subtest: pipe-C-HDMI-A-1
[113.684802] Dynamic subtest pipe-C-HDMI-A-1: SKIP (0.000s)
[113.686488] Subtest compare-crc-sanitycheck-nv12: SUCCESS (0.735s)
[113.780611] [114/164] (888s left) kms_pipe_crc_basic (hang-read-crc)
[113.871550] Starting subtest: hang-read-crc
[113.873100] Starting dynamic subtest: pipe-A-HDMI-A-1
[114.718543] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.845s)
[114.728577] Starting dynamic subtest: pipe-B-HDMI-A-1
[115.546287] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.824s)
[115.554083] Starting dynamic subtest: pipe-C-HDMI-A-1
[116.357571] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.811s)
[116.359137] Subtest hang-read-crc: SUCCESS (2.486s)
[116.439561] [115/164] (886s left) kms_pipe_crc_basic (nonblocking-crc)
[116.530433] Starting subtest: nonblocking-crc
[116.532000] Starting dynamic subtest: pipe-A-HDMI-A-1
[117.011021] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.479s)
[117.018837] Starting dynamic subtest: pipe-B-HDMI-A-1
[117.471755] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.460s)
[117.478616] Starting dynamic subtest: pipe-C-HDMI-A-1
[117.947292] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.474s)
[117.948807] Subtest nonblocking-crc: SUCCESS (1.417s)
[118.030911] [116/164] (884s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[118.121191] Starting subtest: nonblocking-crc-frame-sequence
[118.122667] Starting dynamic subtest: pipe-A-HDMI-A-1
[118.601752] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.480s)
[118.608607] Starting dynamic subtest: pipe-B-HDMI-A-1
[119.080606] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.476s)
[119.088570] Starting dynamic subtest: pipe-C-HDMI-A-1
[119.556490] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.476s)
[119.557910] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.436s)
[119.639669] [117/164] (883s left) kms_pipe_crc_basic (read-crc)
[119.731042] Starting subtest: read-crc
[119.732466] Starting dynamic subtest: pipe-A-HDMI-A-1
[120.161868] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.431s)
[120.171828] Starting dynamic subtest: pipe-B-HDMI-A-1
[120.581269] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.415s)
[120.588949] Starting dynamic subtest: pipe-C-HDMI-A-1
[120.977055] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.396s)
[120.978772] Subtest read-crc: SUCCESS (1.248s)
[121.065278] [118/164] (881s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[121.159321] Starting subtest: read-crc-frame-sequence
[121.160890] Starting dynamic subtest: pipe-A-HDMI-A-1
[121.591931] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.431s)
[121.601115] Starting dynamic subtest: pipe-B-HDMI-A-1
[121.990526] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.396s)
[121.999463] Starting dynamic subtest: pipe-C-HDMI-A-1
[122.387508] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.396s)
[122.389218] Subtest read-crc-frame-sequence: SUCCESS (1.229s)
[122.474451] [119/164] (880s left) kms_pm_backlight (basic-brightness)
[122.567945] Subtest basic-brightness: SKIP (0.000s)
[122.613239] [120/164] (880s left) kms_psr (primary_page_flip)
[122.673548] Subtest primary_page_flip: SKIP (0.000s)
[122.685615] [121/164] (880s left) kms_psr (cursor_plane_move)
[122.723899] Subtest cursor_plane_move: SKIP (0.000s)
[122.736270] [122/164] (880s left) kms_psr (sprite_plane_onoff)
[122.776634] Subtest sprite_plane_onoff: SKIP (0.000s)
[122.803611] [123/164] (879s left) kms_psr (primary_mmap_gtt)
[122.853298] Subtest primary_mmap_gtt: SKIP (0.000s)
[122.869116] [124/164] (879s left) kms_setmode (basic-clone-single-crtc)
[122.912110] Starting subtest: basic-clone-single-crtc
[122.916922] Subtest basic-clone-single-crtc: SKIP (0.001s)
[122.984445] [125/164] (879s left) i915_pm_rpm (basic-pci-d3-state)
[124.400834] Starting subtest: basic-pci-d3-state
[124.783625] Subtest basic-pci-d3-state: SUCCESS (0.383s)
[125.065945] [126/164] (877s left) i915_pm_rpm (basic-rte)
[125.106662] Starting subtest: basic-rte
[126.905646] Subtest basic-rte: SUCCESS (1.796s)
[128.163996] [127/164] (874s left) i915_pm_rps (basic-api)
[128.211476] Starting subtest: basic-api
[128.212951] Subtest basic-api: SUCCESS (0.002s)
[128.276551] [128/164] (874s left) prime_self_import (basic-llseek-bad)
[128.320965] Starting subtest: basic-llseek-bad
[128.323771] Subtest basic-llseek-bad: SUCCESS (0.001s)
[128.394200] [129/164] (874s left) prime_self_import (basic-llseek-size)
[128.439304] Starting subtest: basic-llseek-size
[128.442053] Subtest basic-llseek-size: SUCCESS (0.001s)
[128.518401] [130/164] (874s left) prime_self_import (basic-with_fd_dup)
[128.590390] Starting subtest: basic-with_fd_dup
[128.593150] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[128.692920] [131/164] (874s left) prime_self_import (basic-with_one_bo)
[128.764925] Starting subtest: basic-with_one_bo
[128.767760] Subtest basic-with_one_bo: SUCCESS (0.002s)
[128.819885] [132/164] (874s left) prime_self_import (basic-with_one_bo_two_files)
[128.863929] Starting subtest: basic-with_one_bo_two_files
[128.866909] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s)
[128.981747] [133/164] (874s left) prime_self_import (basic-with_two_bos)
[129.028587] Starting subtest: basic-with_two_bos
[129.031740] Subtest basic-with_two_bos: SUCCESS (0.002s)
[129.095840] [134/164] (873s left) prime_vgem (basic-fence-flip)
[129.148072] Starting subtest: basic-fence-flip
[129.543983] Subtest basic-fence-flip: SUCCESS (0.397s)
[129.651036] [135/164] (873s left) prime_vgem (basic-fence-mmap)
[129.697990] Starting subtest: basic-fence-mmap
[129.713716] Subtest basic-fence-mmap: SUCCESS (0.017s)
[129.813170] [136/164] (873s left) prime_vgem (basic-fence-read)
[129.864723] Starting subtest: basic-fence-read
[129.889747] Subtest basic-fence-read: SUCCESS (0.027s)
[129.985463] [137/164] (873s left) prime_vgem (basic-gtt)
[130.108093] Starting subtest: basic-gtt
[130.131815] Subtest basic-gtt: SUCCESS (0.024s)
[130.244248] [138/164] (872s left) prime_vgem (basic-read)
[130.314435] Starting subtest: basic-read
[130.325399] Subtest basic-read: SUCCESS (0.012s)
[130.430455] [139/164] (872s left) prime_vgem (basic-write)
[130.515062] Starting subtest: basic-write
[130.534811] Subtest basic-write: SUCCESS (0.020s)
[130.622313] [140/164] (872s left) vgem_basic (setversion)
[130.712461] Starting subtest: setversion
[130.716030] Subtest setversion: SUCCESS (0.000s)
[130.773831] [141/164] (872s left) vgem_basic (create)
[130.828680] Starting subtest: create
[130.830416] Subtest create: SUCCESS (0.000s)
[130.877806] [142/164] (872s left) vgem_basic (debugfs)
[130.928793] Starting subtest: debugfs
[130.930283] Subtest debugfs: SUCCESS (0.000s)
[131.000960] [143/164] (872s left) vgem_basic (dmabuf-export)
[131.078346] Starting subtest: dmabuf-export
[131.081745] Subtest dmabuf-export: SUCCESS (0.001s)
[131.196051] [144/164] (872s left) vgem_basic (dmabuf-fence)
[131.262830] Starting subtest: dmabuf-fence
[131.264287] Subtest dmabuf-fence: SUCCESS (0.000s)
[131.337060] [145/164] (872s left) vgem_basic (dmabuf-fence-before)
[131.428658] Starting subtest: dmabuf-fence-before
[131.430178] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[131.478830] [146/164] (871s left) vgem_basic (dmabuf-mmap)
[131.545121] Starting subtest: dmabuf-mmap
[131.552464] Subtest dmabuf-mmap: SUCCESS (0.008s)
[131.593442] [147/164] (871s left) vgem_basic (mmap)
[131.661870] Starting subtest: mmap
[131.667669] Subtest mmap: SUCCESS (0.007s)
[131.728127] [148/164] (871s left) vgem_basic (second-client)
[131.796072] Starting subtest: second-client
[131.828587] Subtest second-client: SUCCESS (0.033s)
[131.878541] [149/164] (871s left) vgem_basic (sysfs)
[131.928202] Starting subtest: sysfs
[131.929903] Subtest sysfs: SUCCESS (0.000s)
[131.980930] [150/164] (871s left) core_hotunplug (unbind-rebind)
[132.077202] Starting subtest: unbind-rebind
[135.442232] Subtest unbind-rebind: SUCCESS (3.365s)
[135.459542] [151/164] (868s left) vgem_basic (unload)
[135.499231] Starting subtest: unload
[164.419949] Subtest unload: SUCCESS (28.920s)
[164.512939] [152/164] (839s left) i915_module_load (reload)
[164.568023] Starting subtest: reload
[166.845782] Subtest reload: SUCCESS (2.279s)
[166.865489] [153/164] (836s left) gem_lmem_swapping (basic)
[166.919606] Subtest basic: SKIP (0.000s)
[166.937556] [154/164] (836s left) gem_lmem_swapping (parallel-random-engines)
[166.975804] Subtest parallel-random-engines: SKIP (0.000s)
[167.031316] [155/164] (836s left) gem_lmem_swapping (random-engines)
[167.106113] Subtest random-engines: SKIP (0.000s)
[167.122778] [156/164] (836s left) gem_lmem_swapping (verify-random)
[167.183243] Subtest verify-random: SKIP (0.000s)
[167.206071] [157/164] (836s left) i915_pm_rpm (module-reload)
[168.983377] Starting subtest: module-reload
[177.696409] Subtest module-reload: SUCCESS (8.715s)
[177.709421] [158/164] (825s left) i915_selftest (live)
[177.767025] Starting subtest: live
[177.768725] Starting dynamic subtest: sanitycheck
[178.866119] Dynamic subtest sanitycheck: SUCCESS (1.099s)
[178.871612] Starting dynamic subtest: uncore
[179.956114] Dynamic subtest uncore: SUCCESS (1.089s)
[179.961978] Starting dynamic subtest: workarounds
[181.301170] Dynamic subtest workarounds: SUCCESS (1.344s)
[181.309889] Starting dynamic subtest: gt_engines
[182.831129] Dynamic subtest gt_engines: SUCCESS (1.529s)
[182.836569] Starting dynamic subtest: gt_timelines
[189.356891] Dynamic subtest gt_timelines: SUCCESS (6.525s)
[189.363929] Starting dynamic subtest: gt_contexts
[190.601949] Dynamic subtest gt_contexts: SUCCESS (1.244s)
[190.608494] Starting dynamic subtest: gt_lrc
[193.974105] Dynamic subtest gt_lrc: SUCCESS (3.371s)
[193.980308] Starting dynamic subtest: gt_mocs
[195.139415] Dynamic subtest gt_mocs: SUCCESS (1.164s)
[195.146054] Starting dynamic subtest: gt_pm
[198.123172] Dynamic subtest gt_pm: SUCCESS (2.983s)
[198.129362] Starting dynamic subtest: gt_heartbeat
[199.337128] Dynamic subtest gt_heartbeat: SUCCESS (1.213s)
[199.343869] Starting dynamic subtest: gt_tlb
[201.296068] Dynamic subtest gt_tlb: SUCCESS (1.958s)
[201.302311] Starting dynamic subtest: requests
[208.693143] Dynamic subtest requests: SUCCESS (7.396s)
[208.698794] Starting dynamic subtest: migrate
[212.655190] Dynamic subtest migrate: SUCCESS (3.961s)
[212.661192] Starting dynamic subtest: active
[213.784017] Dynamic subtest active: SUCCESS (1.128s)
[213.791329] Starting dynamic subtest: objects
[215.392074] Dynamic subtest objects: SUCCESS (1.607s)
[215.397891] Starting dynamic subtest: mman
[219.757271] Dynamic subtest mman: SUCCESS (4.364s)
[219.763569] Starting dynamic subtest: dmabuf
[220.953375] Dynamic subtest dmabuf: SUCCESS (1.195s)
[220.960769] Starting dynamic subtest: vma
[222.072168] Dynamic subtest vma: SUCCESS (1.118s)
[222.078579] Starting dynamic subtest: coherency
[223.693151] Dynamic subtest coherency: SUCCESS (1.620s)
[223.699455] Starting dynamic subtest: gtt
[231.819072] Dynamic subtest gtt: SUCCESS (8.125s)
[231.824667] Starting dynamic subtest: gem
[233.015301] Dynamic subtest gem: SUCCESS (1.195s)
[233.022325] Starting dynamic subtest: evict
[234.837958] Dynamic subtest evict: SUCCESS (1.822s)
[234.843390] Starting dynamic subtest: hugepages
[241.867662] Dynamic subtest hugepages: SUCCESS (7.026s)
[241.873187] Starting dynamic subtest: gem_contexts
[254.526978] Dynamic subtest gem_contexts: SUCCESS (12.661s)
[254.533020] Starting dynamic subtest: client
[255.662126] Dynamic subtest client: SUCCESS (1.134s)
[255.667754] Starting dynamic subtest: gem_migrate
[256.802180] Dynamic subtest gem_migrate: SUCCESS (1.139s)
[256.809281] Starting dynamic subtest: reset
[258.160970] Dynamic subtest reset: SUCCESS (1.358s)
[258.167923] Starting dynamic subtest: memory_region
[259.302117] Dynamic subtest memory_region: SUCCESS (1.140s)
[259.307836] Starting dynamic subtest: hangcheck
[283.343112] Dynamic subtest hangcheck: SUCCESS (24.040s)
[283.349190] Starting dynamic subtest: execlists
[292.238189] Dynamic subtest execlists: SUCCESS (8.894s)
[292.244182] Starting dynamic subtest: ring_submission
[293.339538] Dynamic subtest ring_submission: SUCCESS (1.100s)
[293.345871] Starting dynamic subtest: perf
[294.559151] Dynamic subtest perf: SUCCESS (1.219s)
[294.565221] Starting dynamic subtest: slpc
[295.694456] Dynamic subtest slpc: SUCCESS (1.134s)
[295.700224] Starting dynamic subtest: guc
[296.789192] Dynamic subtest guc: SUCCESS (1.094s)
[296.795179] Starting dynamic subtest: guc_multi_lrc
[297.928144] Dynamic subtest guc_multi_lrc: SUCCESS (1.138s)
[297.934599] Starting dynamic subtest: guc_hang
[299.020227] Dynamic subtest guc_hang: SUCCESS (1.091s)
[299.026610] Starting dynamic subtest: late_gt_pm
[300.227169] Dynamic subtest late_gt_pm: SUCCESS (1.206s)
[300.228742] Subtest live: SUCCESS (122.461s)
[300.241542] [159/164] (703s left) dmabuf (all-tests)
[300.294222] Starting subtest: all-tests
[300.296498] Starting dynamic subtest: sanitycheck
[300.362096] Dynamic subtest sanitycheck: SUCCESS (0.067s)
[300.392075] Starting dynamic subtest: dma_fence
[300.553901] Dynamic subtest dma_fence: SUCCESS (0.189s)
[300.582964] Starting dynamic subtest: dma_fence_chain
[311.001877] Dynamic subtest dma_fence_chain: SUCCESS (10.445s)
[311.008167] Starting dynamic subtest: dma_fence_unwrap
[311.073058] Dynamic subtest dma_fence_unwrap: SUCCESS (0.069s)
[311.082945] Starting dynamic subtest: dma_resv
[311.154080] Dynamic subtest dma_resv: SUCCESS (0.077s)
[311.156680] Subtest all-tests: SUCCESS (10.861s)
[311.209480] [160/164] (692s left) i915_suspend (basic-s2idle-without-i915)
[311.261185] Starting subtest: basic-s2idle-without-i915
[329.179434] Subtest basic-s2idle-without-i915: SUCCESS (2.968s)
[332.312821] [161/164] (689s left) i915_suspend (basic-s3-without-i915)
[332.352732] Starting subtest: basic-s3-without-i915
[351.225597] Subtest basic-s3-without-i915: SUCCESS (2.267s)
[356.498846] [162/164] (686s left) gem_exec_suspend (basic-s0)
[356.551749] Starting subtest: basic-S0
[356.553572] Starting dynamic subtest: smem
[373.666941] Dynamic subtest smem: SUCCESS (1.679s)
[373.668820] Subtest basic-S0: SUCCESS (1.680s)
[385.813204] [163/164] (685s left) gem_exec_suspend (basic-s3)
[385.863143] Starting subtest: basic-S3
[385.864992] Starting dynamic subtest: smem
[403.697140] Dynamic subtest smem: SUCCESS (1.778s)
[403.699080] Subtest basic-S3: SUCCESS (1.779s)
[407.898312] [164/164] (683s left) kms_pipe_crc_basic (suspend-read-crc)
[407.994022] Starting subtest: suspend-read-crc
[407.995793] Starting dynamic subtest: pipe-A-HDMI-A-1
[426.741044] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.673s)
[426.749433] Starting dynamic subtest: pipe-B-HDMI-A-1
[444.780322] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.587s)
[444.788550] Starting dynamic subtest: pipe-C-HDMI-A-1
[462.777478] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.578s)
[462.779254] Subtest suspend-read-crc: SUCCESS (4.841s)
[466.828379] Closing watchdogs
Done.