[24.747123] Initializing watchdogs
[24.747260]   /dev/watchdog0
[24.757148] [001/166] (960s left) i915_module_load (load)
[24.876657] Starting subtest: load
[27.160796] Subtest load: SUCCESS (2.284s)
[27.213044] [002/166] (958s left) core_auth (basic-auth)
[27.377512] Starting subtest: basic-auth
[27.381361] Subtest basic-auth: SUCCESS (0.001s)
[27.446764] [003/166] (957s left) debugfs_test (read_all_entries)
[27.558635] Starting subtest: read_all_entries
[27.629471] Subtest read_all_entries: SUCCESS (0.072s)
[27.697056] [004/166] (957s left) debugfs_test (basic-hwmon)
[27.807101] Starting subtest: basic-hwmon
[27.817224] Subtest basic-hwmon: SKIP (0.000s)
[27.896164] [005/166] (957s left) fbdev (eof)
[28.009820] Starting subtest: eof
[28.013580] Subtest eof: SUCCESS (0.000s)
[28.061489] [006/166] (957s left) fbdev (info)
[28.165962] Starting subtest: info
[28.168694] Subtest info: SUCCESS (0.000s)
[28.229721] [007/166] (957s left) fbdev (nullptr)
[28.342788] Starting subtest: nullptr
[28.346660] Subtest nullptr: SUCCESS (0.000s)
[28.393768] [008/166] (957s left) fbdev (read)
[28.508226] Starting subtest: read
[29.133963] Subtest read: SUCCESS (0.627s)
[29.195586] [009/166] (956s left) fbdev (write)
[29.310282] Starting subtest: write
[29.627010] Subtest write: SUCCESS (0.318s)
[29.678385] [010/166] (955s left) gem_basic (bad-close)
[29.778575] Starting subtest: bad-close
[29.786911] Subtest bad-close: SUCCESS (0.000s)
[29.845771] [011/166] (955s left) gem_basic (create-close)
[29.947200] Starting subtest: create-close
[29.955880] Subtest create-close: SUCCESS (0.000s)
[30.031114] [012/166] (955s left) gem_basic (create-fd-close)
[30.133403] Starting subtest: create-fd-close
[30.139568] Subtest create-fd-close: SUCCESS (0.000s)
[30.221042] [013/166] (955s left) gem_busy (busy@all)
[30.360538] Starting subtest: busy
[30.364249] Starting dynamic subtest: all
[30.399975] Dynamic subtest all: SUCCESS (0.040s)
[30.403640] Subtest busy: SUCCESS (0.040s)
[30.746243] [014/166] (954s left) gem_close_race (basic-process)
[30.857723] Starting subtest: basic-process
[30.913484] Subtest basic-process: SUCCESS (0.054s)
[31.079911] [015/166] (954s left) gem_close_race (basic-threads)
[31.193488] Starting subtest: basic-threads
[32.335339] Subtest basic-threads: SUCCESS (1.142s)
[32.516186] [016/166] (953s left) gem_ctx_create (basic)
[32.622743] Starting subtest: basic
[32.626512] Subtest basic: SUCCESS (0.000s)
[32.793619] [017/166] (952s left) gem_ctx_create (basic-files)
[32.900551] Starting subtest: basic-files
[34.915672] Subtest basic-files: SUCCESS (2.016s)
[35.100212] [018/166] (950s left) gem_ctx_exec (basic)
[35.201937] Starting subtest: basic
[35.206990] Subtest basic: SUCCESS (0.003s)
[35.287721] [019/166] (950s left) gem_exec_basic (basic)
[35.392153] Starting subtest: basic
[35.394652] Starting dynamic subtest: rcs0-smem
[35.398619] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[35.402342] Starting dynamic subtest: bcs0-smem
[35.406370] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[35.411726] Starting dynamic subtest: vcs0-smem
[35.415940] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[35.419887] Starting dynamic subtest: vecs0-smem
[35.424785] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[35.428585] Subtest basic: SUCCESS (0.003s)
[35.560378] [020/166] (950s left) gem_exec_create (basic)
[35.661636] Starting subtest: basic
[35.665346] Starting dynamic subtest: smem
[37.712256] Dynamic subtest smem: SUCCESS (2.050s)
[37.718101] Subtest basic: SUCCESS (2.051s)
[37.878994] [021/166] (947s left) gem_exec_fence (basic-busy)
[38.099815] Starting subtest: basic-busy
[38.104911] Starting dynamic subtest: rcs0
[38.131325] Dynamic subtest rcs0: SUCCESS (0.031s)
[38.133904] Starting dynamic subtest: bcs0
[38.154416] Dynamic subtest bcs0: SUCCESS (0.022s)
[38.158278] Starting dynamic subtest: vcs0
[38.177647] Dynamic subtest vcs0: SUCCESS (0.024s)
[38.182589] Starting dynamic subtest: vecs0
[38.208110] Dynamic subtest vecs0: SUCCESS (0.029s)
[38.210777] Subtest basic-busy: SUCCESS (0.107s)
[38.695059] [022/166] (947s left) gem_exec_fence (basic-wait)
[38.920606] Starting subtest: basic-wait
[38.925736] Starting dynamic subtest: rcs0
[38.948699] Dynamic subtest rcs0: SUCCESS (0.027s)
[38.952428] Starting dynamic subtest: bcs0
[38.969911] Dynamic subtest bcs0: SUCCESS (0.022s)
[38.973618] Starting dynamic subtest: vcs0
[39.001186] Dynamic subtest vcs0: SUCCESS (0.032s)
[39.006030] Starting dynamic subtest: vecs0
[39.030503] Dynamic subtest vecs0: SUCCESS (0.026s)
[39.034391] Subtest basic-wait: SUCCESS (0.108s)
[39.481117] [023/166] (946s left) gem_exec_fence (basic-await)
[39.701145] Starting subtest: basic-await
[39.704611] Starting dynamic subtest: rcs0
[39.787716] Dynamic subtest rcs0: SUCCESS (0.086s)
[39.790243] Starting dynamic subtest: bcs0
[39.870326] Dynamic subtest bcs0: SUCCESS (0.083s)
[39.873912] Starting dynamic subtest: vcs0
[39.953919] Dynamic subtest vcs0: SUCCESS (0.083s)
[39.957670] Starting dynamic subtest: vecs0
[40.039153] Dynamic subtest vecs0: SUCCESS (0.083s)
[40.044051] Subtest basic-await: SUCCESS (0.336s)
[40.479623] [024/166] (945s left) gem_exec_fence (nb-await)
[40.700378] Starting subtest: nb-await
[40.702800] Starting dynamic subtest: rcs0
[40.759663] Dynamic subtest rcs0: SUCCESS (0.060s)
[40.762199] Starting dynamic subtest: bcs0
[40.819182] Dynamic subtest bcs0: SUCCESS (0.059s)
[40.821415] Starting dynamic subtest: vcs0
[40.879296] Dynamic subtest vcs0: SUCCESS (0.060s)
[40.884560] Starting dynamic subtest: vecs0
[40.939786] Dynamic subtest vecs0: SUCCESS (0.060s)
[40.944788] Subtest nb-await: SUCCESS (0.241s)
[41.377082] [025/166] (944s left) gem_exec_gttfill (basic)
[41.481878] Starting subtest: basic
[49.747194] Subtest basic: SUCCESS (8.265s)
[49.918830] [026/166] (935s left) gem_exec_parallel (engines)
[50.090460] Starting subtest: engines
[50.095353] Starting dynamic subtest: basic
[52.757997] Dynamic subtest basic: SUCCESS (2.665s)
[52.762020] Starting dynamic subtest: contexts
[55.920934] Dynamic subtest contexts: SUCCESS (3.165s)
[55.926422] Starting dynamic subtest: fds
[59.506762] Dynamic subtest fds: SUCCESS (3.584s)
[59.512363] Starting dynamic subtest: userptr
[62.255191] Dynamic subtest userptr: SUCCESS (2.748s)
[62.259224] Subtest engines: SUCCESS (12.163s)
[62.434049] [027/166] (923s left) gem_exec_store (basic)
[62.547215] Starting subtest: basic
[62.571389] Subtest basic: SUCCESS (0.032s)
[62.748014] [028/166] (923s left) gem_flink_basic (bad-flink)
[62.844522] Starting subtest: bad-flink
[62.848484] Subtest bad-flink: SUCCESS (0.000s)
[62.915724] [029/166] (922s left) gem_flink_basic (bad-open)
[63.011125] Starting subtest: bad-open
[63.016111] Subtest bad-open: SUCCESS (0.000s)
[63.080901] [030/166] (922s left) gem_flink_basic (basic)
[63.177208] Starting subtest: basic
[63.181326] Subtest basic: SUCCESS (0.000s)
[63.263531] [031/166] (922s left) gem_flink_basic (double-flink)
[63.357813] Starting subtest: double-flink
[63.361946] Subtest double-flink: SUCCESS (0.000s)
[63.446282] [032/166] (922s left) gem_flink_basic (flink-lifetime)
[63.540774] Starting subtest: flink-lifetime
[63.544388] Subtest flink-lifetime: SUCCESS (0.001s)
[63.627155] [033/166] (922s left) gem_huc_copy (huc-copy)
[63.725543] Subtest huc-copy: SKIP (0.000s)
[63.752070] [034/166] (922s left) gem_linear_blits (basic)
[63.931927] Starting subtest: basic
[63.942974] Subtest basic: SUCCESS (0.010s)
[64.067291] [035/166] (921s left) gem_mmap (basic)
[64.245628] Starting subtest: basic
[64.266429] Subtest basic: SUCCESS (0.001s)
[64.329061] [036/166] (921s left) gem_mmap_gtt (basic)
[64.427899] Starting subtest: basic
[64.431786] Subtest basic: SUCCESS (0.000s)
[64.484364] [037/166] (921s left) gem_render_linear_blits (basic)
[64.581857] Starting subtest: basic
[64.623811] Subtest basic: SUCCESS (0.041s)
[64.668448] [038/166] (921s left) gem_render_tiled_blits (basic)
[64.764814] Starting subtest: basic
[64.809567] Subtest basic: SUCCESS (0.045s)
[64.852880] [039/166] (921s left) gem_ringfill (basic-all)
[65.076527] Starting subtest: basic-all
[66.218708] Subtest basic-all: SUCCESS (1.148s)
[66.292509] [040/166] (919s left) gem_softpin (allocator-basic)
[66.390145] Starting subtest: allocator-basic
[66.503945] Subtest allocator-basic: SUCCESS (0.112s)
[66.592728] [041/166] (919s left) gem_softpin (allocator-basic-reserve)
[66.693374] Starting subtest: allocator-basic-reserve
[66.791346] Subtest allocator-basic-reserve: SUCCESS (0.102s)
[66.876375] [042/166] (919s left) gem_softpin (safe-alignment)
[66.970567] Starting subtest: safe-alignment
[66.982279] Subtest safe-alignment: SUCCESS (0.014s)
[67.077991] [043/166] (919s left) gem_sync (basic-all)
[67.199687] Starting subtest: basic-all
[69.542016] Subtest basic-all: SUCCESS (2.116s)
[69.576267] [044/166] (916s left) gem_sync (basic-each)
[69.702584] Starting subtest: basic-each
[71.816516] Subtest basic-each: SUCCESS (2.134s)
[71.993974] [045/166] (914s left) gem_tiled_blits (basic)
[72.169212] Starting subtest: basic
[72.192239] Subtest basic: SUCCESS (0.023s)
[72.319111] [046/166] (913s left) gem_tiled_fence_blits (basic)
[72.578726] Starting subtest: basic
[72.590973] Subtest basic: SUCCESS (0.011s)
[72.717557] [047/166] (913s left) gem_tiled_pread_basic
[73.097242] [048/166] (913s left) gem_wait (busy@all)
[73.204402] Starting subtest: busy
[73.209250] Starting dynamic subtest: all
[73.724362] Dynamic subtest all: SUCCESS (0.519s)
[73.728153] Subtest busy: SUCCESS (0.519s)
[73.907898] [049/166] (912s left) gem_wait (wait@all)
[74.013767] Starting subtest: wait
[74.016260] Starting dynamic subtest: all
[75.054708] Dynamic subtest all: SUCCESS (1.039s)
[75.059752] Subtest wait: SUCCESS (1.039s)
[75.244261] [050/166] (911s left) i915_getparams_basic (basic-eu-total)
[75.343995] Starting subtest: basic-eu-total
[75.351058] Subtest basic-eu-total: SUCCESS (0.000s)
[75.410347] [051/166] (911s left) i915_getparams_basic (basic-subslice-total)
[75.508076] Starting subtest: basic-subslice-total
[75.518038] Subtest basic-subslice-total: SUCCESS (0.000s)
[75.577813] [052/166] (910s left) i915_hangman (error-state-basic)
[75.680621] Starting subtest: error-state-basic
[75.690488] Subtest error-state-basic: SUCCESS (0.005s)
[75.779629] [053/166] (910s left) i915_pciid
[75.943266] [054/166] (910s left) kms_addfb_basic (addfb25-bad-modifier)
[76.053303] Starting subtest: addfb25-bad-modifier
[76.057066] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[76.146983] [055/166] (910s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[76.249064] Starting subtest: addfb25-framebuffer-vs-set-tiling
[76.253152] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[76.346658] [056/166] (910s left) kms_addfb_basic (addfb25-modifier-no-flag)
[76.448108] Starting subtest: addfb25-modifier-no-flag
[76.451791] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[76.546433] [057/166] (910s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[76.645560] Starting subtest: addfb25-x-tiled-legacy
[76.650294] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[76.739372] [058/166] (909s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[76.838475] Starting subtest: addfb25-x-tiled-mismatch-legacy
[76.842057] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[76.945177] [059/166] (909s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[77.051671] Starting subtest: addfb25-yf-tiled-legacy
[77.056547] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[77.144066] [060/166] (909s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[77.254281] Starting subtest: addfb25-y-tiled-legacy
[77.259351] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[77.349171] [061/166] (909s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[77.454187] Starting subtest: addfb25-y-tiled-small-legacy
[77.463765] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[77.551476] [062/166] (909s left) kms_addfb_basic (bad-pitch-0)
[77.648375] Starting subtest: bad-pitch-0
[77.652163] Subtest bad-pitch-0: SUCCESS (0.000s)
[77.744741] [063/166] (908s left) kms_addfb_basic (bad-pitch-1024)
[77.841714] Starting subtest: bad-pitch-1024
[77.845373] Subtest bad-pitch-1024: SUCCESS (0.000s)
[77.943524] [064/166] (908s left) kms_addfb_basic (bad-pitch-128)
[78.038069] Starting subtest: bad-pitch-128
[78.041853] Subtest bad-pitch-128: SUCCESS (0.000s)
[78.143316] [065/166] (908s left) kms_addfb_basic (bad-pitch-256)
[78.241121] Starting subtest: bad-pitch-256
[78.245869] Subtest bad-pitch-256: SUCCESS (0.000s)
[78.346798] [066/166] (908s left) kms_addfb_basic (bad-pitch-32)
[78.441728] Starting subtest: bad-pitch-32
[78.445216] Subtest bad-pitch-32: SUCCESS (0.000s)
[78.546168] [067/166] (908s left) kms_addfb_basic (bad-pitch-63)
[78.648360] Starting subtest: bad-pitch-63
[78.652062] Subtest bad-pitch-63: SUCCESS (0.000s)
[78.745790] [068/166] (908s left) kms_addfb_basic (bad-pitch-65536)
[78.840864] Starting subtest: bad-pitch-65536
[78.845673] Subtest bad-pitch-65536: SUCCESS (0.000s)
[78.942259] [069/166] (907s left) kms_addfb_basic (bad-pitch-999)
[79.038983] Starting subtest: bad-pitch-999
[79.041382] Subtest bad-pitch-999: SUCCESS (0.000s)
[79.144130] [070/166] (907s left) kms_addfb_basic (basic)
[79.239869] Starting subtest: basic
[79.244622] Subtest basic: SUCCESS (0.000s)
[79.343055] [071/166] (907s left) kms_addfb_basic (basic-x-tiled-legacy)
[79.459421] Starting subtest: basic-x-tiled-legacy
[79.464433] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[79.563764] [072/166] (907s left) kms_addfb_basic (basic-y-tiled-legacy)
[79.679670] Starting subtest: basic-y-tiled-legacy
[79.684489] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[79.759450] [073/166] (907s left) kms_addfb_basic (bo-too-small)
[79.856631] Starting subtest: bo-too-small
[79.861731] Subtest bo-too-small: SUCCESS (0.000s)
[79.959236] [074/166] (906s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[80.059688] Starting subtest: bo-too-small-due-to-tiling
[80.064383] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[80.159151] [075/166] (906s left) kms_addfb_basic (clobberred-modifier)
[80.254952] Starting subtest: clobberred-modifier
[80.259949] Subtest clobberred-modifier: SUCCESS (0.000s)
[80.359629] [076/166] (906s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[80.473527] Starting subtest: framebuffer-vs-set-tiling
[80.478659] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[80.559889] [077/166] (906s left) kms_addfb_basic (invalid-get-prop)
[80.673551] Starting subtest: invalid-get-prop
[80.677556] Subtest invalid-get-prop: SUCCESS (0.000s)
[80.765614] [078/166] (906s left) kms_addfb_basic (invalid-get-prop-any)
[80.877952] Starting subtest: invalid-get-prop-any
[80.882798] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[80.975164] [079/166] (906s left) kms_addfb_basic (invalid-set-prop)
[81.086856] Starting subtest: invalid-set-prop
[81.090578] Subtest invalid-set-prop: SUCCESS (0.000s)
[81.178145] [080/166] (905s left) kms_addfb_basic (invalid-set-prop-any)
[81.290497] Starting subtest: invalid-set-prop-any
[81.294320] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[81.377298] [081/166] (905s left) kms_addfb_basic (no-handle)
[81.473048] Starting subtest: no-handle
[81.476806] Subtest no-handle: SUCCESS (0.000s)
[81.576502] [082/166] (905s left) kms_addfb_basic (size-max)
[81.675592] Starting subtest: size-max
[81.680339] Subtest size-max: SUCCESS (0.000s)
[81.780636] [083/166] (905s left) kms_addfb_basic (small-bo)
[81.881823] Starting subtest: small-bo
[81.885482] Subtest small-bo: SUCCESS (0.000s)
[81.978257] [084/166] (905s left) kms_addfb_basic (tile-pitch-mismatch)
[82.086796] Starting subtest: tile-pitch-mismatch
[82.091891] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[82.175331] [085/166] (905s left) kms_addfb_basic (too-high)
[82.275699] Starting subtest: too-high
[82.279409] Subtest too-high: SUCCESS (0.000s)
[82.375327] [086/166] (904s left) kms_addfb_basic (too-wide)
[82.472574] Starting subtest: too-wide
[82.476337] Subtest too-wide: SUCCESS (0.000s)
[82.560657] [087/166] (904s left) kms_addfb_basic (unused-handle)
[82.657413] Starting subtest: unused-handle
[82.665531] Subtest unused-handle: SUCCESS (0.000s)
[82.759551] [088/166] (904s left) kms_addfb_basic (unused-modifier)
[82.853894] Starting subtest: unused-modifier
[82.858755] Subtest unused-modifier: SUCCESS (0.000s)
[82.958366] [089/166] (904s left) kms_addfb_basic (unused-offsets)
[83.055423] Starting subtest: unused-offsets
[83.060395] Subtest unused-offsets: SUCCESS (0.000s)
[83.158477] [090/166] (904s left) kms_addfb_basic (unused-pitches)
[83.256379] Starting subtest: unused-pitches
[83.260118] Subtest unused-pitches: SUCCESS (0.000s)
[83.358194] [091/166] (903s left) kms_busy (basic)
[83.467024] Starting subtest: basic
[83.471168] Starting dynamic subtest: flip
[84.343514] Dynamic subtest flip: SUCCESS (0.875s)
[84.347142] Starting dynamic subtest: modeset
[88.558913] Dynamic subtest modeset: SUCCESS (4.215s)
[88.564326] Subtest basic: SUCCESS (5.090s)
[89.673589] [092/166] (897s left) kms_chamelium (dp-hpd-fast)
[90.055335] Subtest dp-hpd-fast: SKIP (0.000s)
[91.120584] [093/166] (896s left) kms_chamelium (dp-edid-read)
[91.515150] Subtest dp-edid-read: SKIP (0.000s)
[92.575650] [094/166] (894s left) kms_chamelium (dp-crc-fast)
[92.966526] Subtest dp-crc-fast: SKIP (0.000s)
[94.049002] [095/166] (893s left) kms_chamelium (hdmi-hpd-fast)
[94.438578] Subtest hdmi-hpd-fast: SKIP (0.000s)
[95.520175] [096/166] (891s left) kms_chamelium (hdmi-edid-read)
[95.914122] Subtest hdmi-edid-read: SKIP (0.000s)
[96.992919] [097/166] (890s left) kms_chamelium (hdmi-crc-fast)
[97.384561] Subtest hdmi-crc-fast: SKIP (0.000s)
[98.480679] [098/166] (889s left) kms_chamelium (vga-hpd-fast)
[98.875384] Subtest vga-hpd-fast: SKIP (0.000s)
[99.936757] [099/166] (887s left) kms_chamelium (vga-edid-read)
[100.329118] Subtest vga-edid-read: SKIP (0.000s)
[101.408787] [100/166] (886s left) kms_prop_blob (basic)
[101.507961] Starting subtest: basic
[101.512985] Subtest basic: SUCCESS (0.000s)
[101.564168] [101/166] (886s left) kms_cursor_legacy (basic-busy-flip-before-cursor)
[101.672170] Starting subtest: basic-busy-flip-before-cursor
[101.677244] Starting dynamic subtest: legacy
[102.914171] Dynamic subtest legacy: SUCCESS (1.237s)
[102.918911] Starting dynamic subtest: varying-size
[105.102767] Dynamic subtest varying-size: SUCCESS (2.187s)
[105.106970] Starting dynamic subtest: toggle
[107.301070] Dynamic subtest toggle: SUCCESS (2.196s)
[107.305029] Starting dynamic subtest: atomic
[109.538571] Dynamic subtest atomic: SUCCESS (2.240s)
[109.542860] Starting dynamic subtest: atomic-transitions
[111.760554] Dynamic subtest atomic-transitions: SUCCESS (2.223s)
[111.764988] Starting dynamic subtest: atomic-transitions-varying-size
[113.957234] Dynamic subtest atomic-transitions-varying-size: SUCCESS (2.194s)
[113.960273] Subtest basic-busy-flip-before-cursor: SUCCESS (12.283s)
[115.095708] [102/166] (872s left) kms_cursor_legacy (basic-flip-after-cursor)
[115.197930] Starting subtest: basic-flip-after-cursor
[115.201609] Starting dynamic subtest: legacy
[116.426409] Dynamic subtest legacy: SUCCESS (1.226s)
[116.431735] Starting dynamic subtest: varying-size
[118.626641] Dynamic subtest varying-size: SUCCESS (2.199s)
[118.630787] Starting dynamic subtest: toggle
[120.849120] Dynamic subtest toggle: SUCCESS (2.224s)
[120.853183] Starting dynamic subtest: atomic
[123.043687] Dynamic subtest atomic: SUCCESS (2.193s)
[123.048878] Starting dynamic subtest: atomic-transitions
[125.518145] Dynamic subtest atomic-transitions: SUCCESS (2.241s)
[125.523931] Starting dynamic subtest: atomic-transitions-varying-size
[127.507485] Dynamic subtest atomic-transitions-varying-size: SUCCESS (2.222s)
[127.509794] Subtest basic-flip-after-cursor: SUCCESS (12.307s)
[128.584343] [103/166] (859s left) kms_cursor_legacy (basic-flip-before-cursor)
[128.686488] Starting subtest: basic-flip-before-cursor
[128.691533] Starting dynamic subtest: legacy
[129.916440] Dynamic subtest legacy: SUCCESS (1.229s)
[129.920485] Starting dynamic subtest: varying-size
[132.097966] Dynamic subtest varying-size: SUCCESS (2.181s)
[132.100718] Starting dynamic subtest: toggle
[134.289940] Dynamic subtest toggle: SUCCESS (2.191s)
[134.295306] Starting dynamic subtest: atomic
[136.482022] Dynamic subtest atomic: SUCCESS (2.190s)
[136.487021] Starting dynamic subtest: atomic-transitions
[138.707533] Dynamic subtest atomic-transitions: SUCCESS (2.226s)
[138.709767] Starting dynamic subtest: atomic-transitions-varying-size
[140.899383] Dynamic subtest atomic-transitions-varying-size: SUCCESS (2.192s)
[140.904299] Subtest basic-flip-before-cursor: SUCCESS (12.212s)
[142.025899] [104/166] (845s left) kms_flip (basic-flip-vs-dpms)
[142.128885] Starting subtest: basic-flip-vs-dpms
[142.131165] Starting dynamic subtest: A-eDP1
[145.330387] Dynamic subtest A-eDP1: SUCCESS (3.202s)
[145.333937] Starting dynamic subtest: B-eDP1
[148.095489] Dynamic subtest B-eDP1: SUCCESS (2.764s)
[148.100851] Starting dynamic subtest: C-eDP1
[150.782707] Dynamic subtest C-eDP1: SUCCESS (2.687s)
[150.786527] Subtest basic-flip-vs-dpms: SUCCESS (8.660s)
[151.882530] [105/166] (835s left) kms_flip (basic-flip-vs-modeset)
[151.982624] Starting subtest: basic-flip-vs-modeset
[151.986279] Starting dynamic subtest: A-eDP1
[155.138370] Dynamic subtest A-eDP1: SUCCESS (3.155s)
[155.144042] Starting dynamic subtest: B-eDP1
[157.822733] Dynamic subtest B-eDP1: SUCCESS (2.684s)
[157.828363] Starting dynamic subtest: C-eDP1
[160.575870] Dynamic subtest C-eDP1: SUCCESS (2.750s)
[160.579946] Subtest basic-flip-vs-modeset: SUCCESS (8.599s)
[161.688297] [106/166] (826s left) kms_flip (basic-flip-vs-wf_vblank)
[161.789335] Starting subtest: basic-flip-vs-wf_vblank
[161.791936] Starting dynamic subtest: A-eDP1
[164.233407] Dynamic subtest A-eDP1: SUCCESS (2.446s)
[164.237855] Starting dynamic subtest: B-eDP1
[166.631586] Dynamic subtest B-eDP1: SUCCESS (2.396s)
[166.635783] Starting dynamic subtest: C-eDP1
[168.998483] Dynamic subtest C-eDP1: SUCCESS (2.366s)
[169.003268] Subtest basic-flip-vs-wf_vblank: SUCCESS (7.216s)
[170.391975] [107/166] (817s left) kms_flip (basic-plain-flip)
[170.492673] Starting subtest: basic-plain-flip
[170.497602] Starting dynamic subtest: A-eDP1
[172.653918] Dynamic subtest A-eDP1: SUCCESS (2.163s)
[172.659202] Starting dynamic subtest: B-eDP1
[174.813482] Dynamic subtest B-eDP1: SUCCESS (2.157s)
[174.818028] Starting dynamic subtest: C-eDP1
[176.908070] Dynamic subtest C-eDP1: SUCCESS (2.095s)
[176.911711] Subtest basic-plain-flip: SUCCESS (6.423s)
[178.330717] [108/166] (809s left) kms_force_connector_basic (force-connector-state)
[178.434973] Subtest force-connector-state: SKIP (0.000s)
[178.458203] [109/166] (809s left) kms_force_connector_basic (force-edid)
[178.563025] Subtest force-edid: SKIP (0.000s)
[178.583920] [110/166] (809s left) kms_force_connector_basic (force-load-detect)
[178.684530] Subtest force-load-detect: SKIP (0.000s)
[178.720050] [111/166] (809s left) kms_force_connector_basic (prune-stale-modes)
[178.827581] Subtest prune-stale-modes: SKIP (0.000s)
[178.852037] [112/166] (809s left) kms_frontbuffer_tracking (basic)
[178.973148] Starting subtest: basic
[182.206609] Subtest basic: SUCCESS (3.242s)
[182.312152] [113/166] (805s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[182.413015] Starting subtest: compare-crc-sanitycheck
[182.417898] Starting dynamic subtest: pipe-A-eDP-1
[183.057027] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.642s)
[183.062584] Starting dynamic subtest: pipe-B-eDP-1
[184.549199] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.493s)
[184.554060] Starting dynamic subtest: pipe-C-eDP-1
[186.086560] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s)
[186.090448] Subtest compare-crc-sanitycheck: SUCCESS (3.671s)
[187.214628] [114/166] (800s left) kms_pipe_crc_basic (hang-read-crc)
[187.316746] Starting subtest: hang-read-crc
[187.320549] Starting dynamic subtest: pipe-A-eDP-1
[189.825810] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.505s)
[189.828629] Starting dynamic subtest: pipe-B-eDP-1
[193.082404] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.257s)
[193.086631] Starting dynamic subtest: pipe-C-eDP-1
[196.395478] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.313s)
[196.399247] Subtest hang-read-crc: SUCCESS (9.076s)
[197.513259] [115/166] (790s left) kms_pipe_crc_basic (nonblocking-crc)
[197.619450] Starting subtest: nonblocking-crc
[197.624277] Starting dynamic subtest: pipe-A-eDP-1
[198.459178] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.840s)
[198.463001] Starting dynamic subtest: pipe-B-eDP-1
[200.174550] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.713s)
[200.178694] Starting dynamic subtest: pipe-C-eDP-1
[201.904314] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.730s)
[201.908347] Subtest nonblocking-crc: SUCCESS (4.283s)
[203.023063] [116/166] (784s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[203.124891] Starting subtest: nonblocking-crc-frame-sequence
[203.130273] Starting dynamic subtest: pipe-A-eDP-1
[203.980711] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.854s)
[203.985527] Starting dynamic subtest: pipe-B-eDP-1
[205.663468] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.681s)
[205.667351] Starting dynamic subtest: pipe-C-eDP-1
[207.406666] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.743s)
[207.411169] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.279s)
[208.521047] [117/166] (779s left) kms_pipe_crc_basic (read-crc)
[208.624871] Starting subtest: read-crc
[208.629016] Starting dynamic subtest: pipe-A-eDP-1
[209.435448] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.808s)
[209.440623] Starting dynamic subtest: pipe-B-eDP-1
[211.052937] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.616s)
[211.056888] Starting dynamic subtest: pipe-C-eDP-1
[212.715627] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.664s)
[212.719729] Subtest read-crc: SUCCESS (4.089s)
[213.832260] [118/166] (774s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[213.932939] Starting subtest: read-crc-frame-sequence
[213.936764] Starting dynamic subtest: pipe-A-eDP-1
[214.714925] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.781s)
[214.718427] Starting dynamic subtest: pipe-B-eDP-1
[216.363500] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.649s)
[216.367173] Starting dynamic subtest: pipe-C-eDP-1
[218.043637] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.679s)
[218.046741] Subtest read-crc-frame-sequence: SUCCESS (4.110s)
[219.157502] [119/166] (768s left) kms_psr (primary_page_flip)
[219.258028] Subtest primary_page_flip: SKIP (0.000s)
[219.285429] [120/166] (768s left) kms_psr (cursor_plane_move)
[219.386215] Subtest cursor_plane_move: SKIP (0.000s)
[219.415353] [121/166] (768s left) kms_psr (sprite_plane_onoff)
[219.515860] Subtest sprite_plane_onoff: SKIP (0.000s)
[219.552442] [122/166] (768s left) kms_psr (primary_mmap_gtt)
[219.648568] Subtest primary_mmap_gtt: SKIP (0.000s)
[219.687631] [123/166] (768s left) kms_setmode (basic-clone-single-crtc)
[219.784665] Starting subtest: basic-clone-single-crtc
[219.797497] Subtest basic-clone-single-crtc: SKIP (0.000s)
[219.841945] [124/166] (768s left) i915_pm_backlight (basic-brightness)
[219.945878] Starting subtest: basic-brightness
[220.024409] Starting dynamic subtest: eDP-1
[220.549146] Dynamic subtest eDP-1: SUCCESS (0.519s)
[220.554031] Subtest basic-brightness: SUCCESS (0.595s)
[221.657668] [125/166] (766s left) i915_pm_rpm (basic-pci-d3-state)
[223.341050] Starting subtest: basic-pci-d3-state
[228.093571] Subtest basic-pci-d3-state: SUCCESS (4.708s)
[228.157802] [126/166] (760s left) i915_pm_rpm (basic-rte)
[228.254581] Starting subtest: basic-rte
[234.528086] Subtest basic-rte: SUCCESS (6.245s)
[235.850814] [127/166] (752s left) i915_pm_rps (basic-api)
[235.948796] Starting subtest: basic-api
[235.952718] Subtest basic-api: SUCCESS (0.004s)
[236.013986] [128/166] (752s left) prime_self_import (basic-llseek-bad)
[236.109794] Starting subtest: basic-llseek-bad
[236.112648] Subtest basic-llseek-bad: SUCCESS (0.001s)
[236.183866] [129/166] (752s left) prime_self_import (basic-llseek-size)
[236.281566] Starting subtest: basic-llseek-size
[236.285219] Subtest basic-llseek-size: SUCCESS (0.003s)
[236.363504] [130/166] (751s left) prime_self_import (basic-with_fd_dup)
[236.456946] Starting subtest: basic-with_fd_dup
[236.460716] Subtest basic-with_fd_dup: SUCCESS (0.002s)
[236.546457] [131/166] (751s left) prime_self_import (basic-with_one_bo)
[236.643198] Starting subtest: basic-with_one_bo
[236.647102] Subtest basic-with_one_bo: SUCCESS (0.003s)
[236.707705] [132/166] (751s left) prime_self_import (basic-with_one_bo_two_files)
[236.807809] Starting subtest: basic-with_one_bo_two_files
[236.812903] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s)
[236.883966] [133/166] (751s left) prime_self_import (basic-with_two_bos)
[236.981129] Starting subtest: basic-with_two_bos
[236.984744] Subtest basic-with_two_bos: SUCCESS (0.002s)
[237.067174] [134/166] (751s left) prime_vgem (basic-fence-flip)
[237.189340] Starting subtest: basic-fence-flip
[237.591019] Subtest basic-fence-flip: SUCCESS (0.402s)
[237.717314] [135/166] (750s left) prime_vgem (basic-fence-mmap)
[237.842145] Starting subtest: basic-fence-mmap
[237.869002] Subtest basic-fence-mmap: SUCCESS (0.029s)
[237.965403] [136/166] (750s left) prime_vgem (basic-fence-read)
[238.090421] Starting subtest: basic-fence-read
[238.130939] Subtest basic-fence-read: SUCCESS (0.043s)
[238.199802] [137/166] (750s left) prime_vgem (basic-gtt)
[238.328386] Starting subtest: basic-gtt
[238.338717] Subtest basic-gtt: SUCCESS (0.015s)
[238.416253] [138/166] (750s left) prime_vgem (basic-read)
[238.537155] Starting subtest: basic-read
[238.557463] Subtest basic-read: SUCCESS (0.022s)
[238.651444] [139/166] (749s left) prime_vgem (basic-write)
[238.772536] Starting subtest: basic-write
[238.796814] Subtest basic-write: SUCCESS (0.024s)
[238.865039] [140/166] (749s left) prime_vgem (basic-userptr)
[238.981598] Starting subtest: basic-userptr
[238.995868] Subtest basic-userptr: SKIP (0.011s)
[239.100561] [141/166] (749s left) vgem_basic (setversion)
[239.210395] Starting subtest: setversion
[239.219328] Subtest setversion: SUCCESS (0.000s)
[239.263133] [142/166] (749s left) vgem_basic (create)
[239.358446] Starting subtest: create
[239.363405] Subtest create: SUCCESS (0.000s)
[239.418562] [143/166] (749s left) vgem_basic (debugfs)
[239.524946] Starting subtest: debugfs
[239.529865] Subtest debugfs: SUCCESS (0.000s)
[239.581304] [144/166] (749s left) vgem_basic (dmabuf-export)
[239.691873] Starting subtest: dmabuf-export
[239.703346] Subtest dmabuf-export: SUCCESS (0.011s)
[239.785487] [145/166] (748s left) vgem_basic (dmabuf-fence)
[239.894005] Starting subtest: dmabuf-fence
[239.899035] Subtest dmabuf-fence: SUCCESS (0.002s)
[239.948054] [146/166] (748s left) vgem_basic (dmabuf-fence-before)
[240.040643] Starting subtest: dmabuf-fence-before
[240.044398] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[240.098268] [147/166] (748s left) vgem_basic (dmabuf-mmap)
[240.210306] Starting subtest: dmabuf-mmap
[240.230458] Subtest dmabuf-mmap: SUCCESS (0.022s)
[240.280722] [148/166] (748s left) vgem_basic (mmap)
[240.392958] Starting subtest: mmap
[240.404883] Subtest mmap: SUCCESS (0.015s)
[240.466390] [149/166] (748s left) vgem_basic (second-client)
[240.576099] Starting subtest: second-client
[240.626993] Subtest second-client: SUCCESS (0.051s)
[240.685981] [150/166] (748s left) vgem_basic (sysfs)
[240.792427] Starting subtest: sysfs
[240.795993] Subtest sysfs: SUCCESS (0.002s)
[240.852728] [151/166] (747s left) core_hotunplug (unbind-rebind)
[240.975217] Starting subtest: unbind-rebind
[242.909307] Subtest unbind-rebind: SUCCESS (1.934s)
[242.942812] [152/166] (745s left) vgem_basic (unload)
[243.062931] Starting subtest: unload
[243.301666] Subtest unload: SUCCESS (0.238s)
[243.399139] [153/166] (745s left) i915_module_load (reload)
[243.497177] Starting subtest: reload
[246.461937] Subtest reload: SUCCESS (2.958s)
[246.486968] [154/166] (742s left) gem_lmem_swapping (basic)
[246.645090] Subtest basic: SKIP (0.000s)
[246.685131] [155/166] (742s left) gem_lmem_swapping (parallel-random-engines)
[246.791089] Subtest parallel-random-engines: SKIP (0.000s)
[246.834134] [156/166] (742s left) gem_lmem_swapping (random-engines)
[246.939536] Subtest random-engines: SKIP (0.000s)
[246.963285] [157/166] (742s left) gem_lmem_swapping (verify-random)
[247.069968] Subtest verify-random: SKIP (0.000s)
[247.098160] [158/166] (741s left) i915_pm_rpm (module-reload)
[249.406008] Starting subtest: module-reload
[261.026088] Subtest module-reload: SUCCESS (11.619s)
[261.047283] [159/166] (727s left) i915_selftest (live)
[261.158163] Starting subtest: live
[261.163225] Starting dynamic subtest: sanitycheck
[262.691427] Dynamic subtest sanitycheck: SUCCESS (1.533s)
[262.696214] Starting dynamic subtest: uncore
[264.236952] Dynamic subtest uncore: SUCCESS (1.545s)
[264.240602] Starting dynamic subtest: workarounds
[265.897511] Dynamic subtest workarounds: SUCCESS (1.662s)
[265.902333] Starting dynamic subtest: gt_engines
[267.428618] Dynamic subtest gt_engines: SUCCESS (1.530s)
[267.431115] Starting dynamic subtest: gt_timelines
[277.404163] Dynamic subtest gt_timelines: SUCCESS (9.975s)
[277.407972] Starting dynamic subtest: gt_contexts
[278.917543] Dynamic subtest gt_contexts: SUCCESS (1.513s)
[278.921359] Starting dynamic subtest: gt_lrc
[282.981482] Dynamic subtest gt_lrc: SUCCESS (4.063s)
[282.986863] Starting dynamic subtest: gt_mocs
[284.439577] Dynamic subtest gt_mocs: SUCCESS (1.459s)
[284.444466] Starting dynamic subtest: gt_pm
[287.741723] Dynamic subtest gt_pm: SUCCESS (3.301s)
[287.746861] Starting dynamic subtest: gt_heartbeat
[289.404911] Dynamic subtest gt_heartbeat: SUCCESS (1.662s)
[289.408582] Starting dynamic subtest: requests
[296.126300] Dynamic subtest requests: SUCCESS (6.722s)
[296.130148] Starting dynamic subtest: migrate
[298.224426] Dynamic subtest migrate: SUCCESS (2.096s)
[298.228603] Starting dynamic subtest: active
[299.729325] Dynamic subtest active: SUCCESS (1.500s)
[299.732056] Starting dynamic subtest: objects
[302.304235] Dynamic subtest objects: SUCCESS (2.580s)
[302.307777] Starting dynamic subtest: mman
[308.165050] Dynamic subtest mman: SUCCESS (5.860s)
[308.168741] Starting dynamic subtest: dmabuf
[309.556986] Dynamic subtest dmabuf: SUCCESS (1.394s)
[309.562185] Starting dynamic subtest: vma
[311.115477] Dynamic subtest vma: SUCCESS (1.556s)
[311.120940] Starting dynamic subtest: coherency
[313.661701] Dynamic subtest coherency: SUCCESS (2.546s)
[313.666045] Starting dynamic subtest: gtt
[324.719911] Dynamic subtest gtt: SUCCESS (11.058s)
[324.723974] Starting dynamic subtest: gem
[326.443807] Dynamic subtest gem: SUCCESS (1.722s)
[326.447488] Starting dynamic subtest: evict
[329.345585] Dynamic subtest evict: SUCCESS (2.902s)
[329.349419] Starting dynamic subtest: hugepages
[331.425994] Dynamic subtest hugepages: SUCCESS (2.079s)
[331.428444] Starting dynamic subtest: gem_contexts
[344.887299] Dynamic subtest gem_contexts: SUCCESS (13.460s)
[344.893114] Starting dynamic subtest: client
[346.332342] Dynamic subtest client: SUCCESS (1.447s)
[346.337485] Starting dynamic subtest: gem_migrate
[347.757772] Dynamic subtest gem_migrate: SUCCESS (1.424s)
[347.763028] Starting dynamic subtest: reset
[350.146417] Dynamic subtest reset: SUCCESS (2.389s)
[350.150268] Starting dynamic subtest: memory_region
[351.718016] Dynamic subtest memory_region: SUCCESS (1.571s)
[351.722814] Starting dynamic subtest: hangcheck
[376.274679] Dynamic subtest hangcheck: SUCCESS (24.556s)
[376.277314] Starting dynamic subtest: execlists
[384.991347] Dynamic subtest execlists: SUCCESS (8.716s)
[384.995059] Starting dynamic subtest: ring_submission
[386.621973] Dynamic subtest ring_submission: SUCCESS (1.629s)
[386.625723] Starting dynamic subtest: perf
[388.371101] Dynamic subtest perf: SUCCESS (1.748s)
[388.375485] Starting dynamic subtest: slpc
[389.955142] Dynamic subtest slpc: SUCCESS (1.586s)
[389.960704] Starting dynamic subtest: guc
[391.525790] Dynamic subtest guc: SUCCESS (1.568s)
[391.529561] Starting dynamic subtest: guc_multi_lrc
[393.041246] Dynamic subtest guc_multi_lrc: SUCCESS (1.514s)
[393.044948] Starting dynamic subtest: guc_hang
[394.830080] Dynamic subtest guc_hang: SUCCESS (1.481s)
[394.835019] Starting dynamic subtest: late_gt_pm
[395.974030] Dynamic subtest late_gt_pm: SUCCESS (1.453s)
[395.978937] Subtest live: SUCCESS (134.817s)
[396.074247] [160/166] (592s left) dmabuf (all)
[396.177637] Starting subtest: all
[396.182369] Starting dynamic subtest: sanitycheck
[396.197710] Dynamic subtest sanitycheck: SUCCESS (0.026s)
[396.201566] Starting dynamic subtest: dma_fence
[396.328083] Dynamic subtest dma_fence: SUCCESS (0.129s)
[396.331696] Starting dynamic subtest: dma_fence_chain
[411.583563] Dynamic subtest dma_fence_chain: SUCCESS (15.255s)
[411.589020] Starting dynamic subtest: dma_fence_unwrap
[411.612316] Dynamic subtest dma_fence_unwrap: SUCCESS (0.028s)
[411.617497] Starting dynamic subtest: dma_resv
[411.629059] Dynamic subtest dma_resv: SUCCESS (0.017s)
[411.634512] Subtest all: SUCCESS (15.455s)
[411.655270] [161/166] (577s left) i915_suspend (basic-s2idle-without-i915)
[411.753914] Starting subtest: basic-s2idle-without-i915
[430.787650] Subtest basic-s2idle-without-i915: SUCCESS (5.057s)
[432.918425] [162/166] (572s left) i915_suspend (basic-s3-without-i915)
[433.020485] Starting subtest: basic-s3-without-i915
[450.747007] Subtest basic-s3-without-i915: SUCCESS (2.514s)
[452.865491] [163/166] (569s left) gem_exec_suspend (basic-s0)
[452.994784] Starting subtest: basic-S0
[452.997518] Starting dynamic subtest: smem