tests/vlog.at

   1 AT_BANNER([vlog])
   2
   3 AT_SETUP([vlog - Python3])
   4 AT_CAPTURE_FILE([log_file])
   5 AT_CAPTURE_FILE([stderr_log])
   6 AT_CHECK([$PYTHON3 $srcdir/test-vlog.py --log-file log_file \
   7 -v dbg module_1:info module_2:warn syslog:off 2>stderr_log])
   8
   9 AT_CHECK([sed -e 's/.*-.*-.*T..:..:..Z |//' \
  10 -e 's/File ".*", line [[0-9]][[0-9]]*,/File <name>, line <number>,/' \
  11 stderr_log], [0], [dnl
  12   0  | module_0 | EMER | emergency
  13   1  | module_0 | ERR | error
  14   2  | module_0 | WARN | warning
  15   3  | module_0 | INFO | information
  16   4  | module_0 | DBG | debug
  17   5  | module_0 | EMER | emergency exception
  18 Traceback (most recent call last):
  19   File <name>, line <number>, in main
  20     assert fail
  21 AssertionError
  22   6  | module_0 | ERR | error exception
  23 Traceback (most recent call last):
  24   File <name>, line <number>, in main
  25     assert fail
  26 AssertionError
  27   7  | module_0 | WARN | warn exception
  28 Traceback (most recent call last):
  29   File <name>, line <number>, in main
  30     assert fail
  31 AssertionError
  32   8  | module_0 | INFO | information exception
  33 Traceback (most recent call last):
  34   File <name>, line <number>, in main
  35     assert fail
  36 AssertionError
  37   9  | module_0 | DBG | debug exception
  38 Traceback (most recent call last):
  39   File <name>, line <number>, in main
  40     assert fail
  41 AssertionError
  42   10 | module_0 | ERR | exception
  43 Traceback (most recent call last):
  44   File <name>, line <number>, in main
  45     assert fail
  46 AssertionError
  47   11 | module_1 | EMER | emergency
  48   12 | module_1 | ERR | error
  49   13 | module_1 | WARN | warning
  50   14 | module_1 | INFO | information
  51   16 | module_1 | EMER | emergency exception
  52 Traceback (most recent call last):
  53   File <name>, line <number>, in main
  54     assert fail
  55 AssertionError
  56   17 | module_1 | ERR | error exception
  57 Traceback (most recent call last):
  58   File <name>, line <number>, in main
  59     assert fail
  60 AssertionError
  61   18 | module_1 | WARN | warn exception
  62 Traceback (most recent call last):
  63   File <name>, line <number>, in main
  64     assert fail
  65 AssertionError
  66   19 | module_1 | INFO | information exception
  67 Traceback (most recent call last):
  68   File <name>, line <number>, in main
  69     assert fail
  70 AssertionError
  71   21 | module_1 | ERR | exception
  72 Traceback (most recent call last):
  73   File <name>, line <number>, in main
  74     assert fail
  75 AssertionError
  76   22 | module_2 | EMER | emergency
  77   23 | module_2 | ERR | error
  78   24 | module_2 | WARN | warning
  79   27 | module_2 | EMER | emergency exception
  80 Traceback (most recent call last):
  81   File <name>, line <number>, in main
  82     assert fail
  83 AssertionError
  84   28 | module_2 | ERR | error exception
  85 Traceback (most recent call last):
  86   File <name>, line <number>, in main
  87     assert fail
  88 AssertionError
  89   29 | module_2 | WARN | warn exception
  90 Traceback (most recent call last):
  91   File <name>, line <number>, in main
  92     assert fail
  93 AssertionError
  94   32 | module_2 | ERR | exception
  95 Traceback (most recent call last):
  96   File <name>, line <number>, in main
  97     assert fail
  98 AssertionError
  99 ])
 100
 101 AT_CLEANUP
 102
 103 m4_divert_push([PREPARE_TESTS])
 104 vlog_filt () {
 105     sed 's/.*\(opened log file\).*/\1/
 106 s/.*|//' "$@"
 107 }
 108 m4_divert_pop([PREPARE_TESTS])
 109
 110 AT_SETUP([vlog - vlog/reopen - C])
 111 # This test won't work as-is on Windows because Windows doesn't allow
 112 # files that are open to be renamed.
 113 AT_SKIP_IF([test "$IS_WIN32" = "yes"])
 114 on_exit 'kill `cat test-unixctl.pid`'
 115
 116 AT_CAPTURE_FILE([log])
 117 AT_CAPTURE_FILE([log.old])
 118 AT_CHECK([ovstest test-unixctl --log-file=`pwd`/log --pidfile --detach --no-chdir],
 119   [0], [], [stderr])
 120 AT_CHECK([vlog_filt stderr], [0],
 121   [opened log file
 122 ])
 123
 124 AT_CHECK([APPCTL -t test-unixctl log message])
 125 mv log log.old
 126 AT_CHECK([APPCTL -t test-unixctl log message2])
 127 AT_CHECK([APPCTL -t test-unixctl vlog/reopen])
 128 AT_CHECK([APPCTL -t test-unixctl log message3])
 129 AT_CHECK([APPCTL -t test-unixctl exit])
 130
 131 AT_CHECK([vlog_filt log.old], [0], [dnl
 132 opened log file
 133 Entering run loop.
 134 message
 135 message2
 136 closing log file
 137 ])
 138 AT_CHECK([vlog_filt log], [0], [dnl
 139 opened log file
 140 message3
 141 ])
 142 AT_CLEANUP
 143
 144 AT_SETUP([vlog - vlog/reopen - Python3])
 145 # This test won't work as-is on Windows because Windows doesn't allow
 146 # files that are open to be renamed.
 147 AT_SKIP_IF([test "$IS_WIN32" = "yes"])
 148 on_exit 'kill `cat test-unixctl.py.pid`'
 149
 150 AT_CAPTURE_FILE([log])
 151 AT_CAPTURE_FILE([log.old])
 152 AT_CHECK([$PYTHON3 $srcdir/test-unixctl.py --log-file=`pwd`/log --pidfile --detach --no-chdir])
 153
 154 AT_CHECK([APPCTL -t test-unixctl.py log message])
 155 mv log log.old
 156 AT_CHECK([APPCTL -t test-unixctl.py log message2])
 157 AT_CHECK([APPCTL -t test-unixctl.py vlog/reopen])
 158 AT_CHECK([APPCTL -t test-unixctl.py log message3])
 159 AT_CHECK([APPCTL -t test-unixctl.py exit])
 160
 161 AT_CHECK([sed 's/.*|//' log.old], [0], [dnl
 162  Entering run loop.
 163  message
 164  message2
 165 ])
 166 AT_CHECK([sed 's/.*|//' log], [0], [dnl
 167  message3
 168 ])
 169 AT_CLEANUP
 170
 171 AT_SETUP([vlog - vlog/reopen without log file - C])
 172 on_exit 'kill `cat test-unixctl.pid`'
 173
 174 AT_CHECK([ovstest test-unixctl --pidfile --detach --no-chdir])
 175
 176 AT_CHECK([APPCTL -t test-unixctl vlog/reopen], [2], [],
 177   [Logging to file not configured
 178 ovs-appctl: test-unixctl: server returned an error
 179 ])
 180 OVS_APP_EXIT_AND_WAIT([test-unixctl])
 181 AT_CLEANUP
 182
 183 AT_SETUP([vlog - vlog/reopen without log file - Python3])
 184 on_exit 'kill `cat test-unixctl.py.pid`'
 185
 186 AT_CHECK([$PYTHON3 $srcdir/test-unixctl.py --pidfile --detach --no-chdir])
 187
 188 AT_CHECK([APPCTL -t test-unixctl.py vlog/reopen], [0],
 189   [Logging to file not configured
 190 ])
 191 AT_CLEANUP
 192
 193 dnl This checks that if vlog/reopen can't reopen the log file,
 194 dnl nothing particularly bad (e.g. a crash) happens.
 195 AT_SETUP([vlog - vlog/reopen can't reopen log file - C])
 196 # Verify that /dev/full is a character device that fails writes.
 197 AT_SKIP_IF([test ! -c /dev/full])
 198 AT_SKIP_IF([echo > /dev/full])
 199
 200 on_exit 'kill `cat test-unixctl.pid`'
 201
 202 AT_CHECK([ovstest test-unixctl --log-file=`pwd`/log --pidfile --detach --no-chdir],
 203   [0], [], [stderr])
 204 AT_CHECK([vlog_filt stderr], [0], [opened log file
 205 ])
 206
 207 AT_CHECK([APPCTL -t test-unixctl log message])
 208 mv log log.old
 209 ln -s /dev/full log
 210 AT_CHECK([APPCTL -t test-unixctl vlog/reopen])
 211 AT_CHECK([APPCTL -t test-unixctl log message2])
 212 rm log
 213 AT_CHECK([APPCTL -t test-unixctl vlog/reopen])
 214 AT_CHECK([APPCTL -t test-unixctl log message3])
 215 AT_CHECK([APPCTL -t test-unixctl exit])
 216 AT_CHECK([vlog_filt log.old], [0], [dnl
 217 opened log file
 218 Entering run loop.
 219 message
 220 closing log file
 221 ])
 222 AT_CHECK([vlog_filt log], [0], [dnl
 223 opened log file
 224 message3
 225 ])
 226 AT_CLEANUP
 227
 228 dnl This checks that if vlog/reopen can't reopen the log file,
 229 dnl nothing particularly bad (e.g. Python throws an exception and
 230 dnl aborts the program) happens.
 231 AT_SETUP([vlog - vlog/reopen can't reopen log file - Python3])
 232
 233 # Verify that /dev/full is a character device that fails writes.
 234 AT_SKIP_IF([test ! -c /dev/full])
 235 AT_SKIP_IF([echo > /dev/full])
 236
 237 on_exit 'kill `cat test-unixctl.py.pid`'
 238
 239 AT_CHECK([$PYTHON3 $srcdir/test-unixctl.py --log-file=`pwd`/log --pidfile --detach --no-chdir])
 240 AT_CHECK([APPCTL -t test-unixctl.py log message])
 241 mv log log.old
 242 ln -s /dev/full log
 243 AT_CHECK([APPCTL -t test-unixctl.py vlog/reopen])
 244 AT_CHECK([APPCTL -t test-unixctl.py log message2])
 245 rm log
 246 AT_CHECK([APPCTL -t test-unixctl.py vlog/reopen])
 247 AT_CHECK([APPCTL -t test-unixctl.py log message3])
 248 AT_CHECK([APPCTL -t test-unixctl.py exit])
 249 AT_CHECK([sed 's/.*|//' log.old], [0], [dnl
 250  Entering run loop.
 251  message
 252 ])
 253 AT_CHECK([sed 's/.*|//' log], [0], [dnl
 254  message3
 255 ])
 256 AT_CLEANUP
 257
 258 AT_SETUP([vlog - vlog/close - C])
 259 on_exit 'kill `cat test-unixctl.pid`'
 260
 261 AT_CAPTURE_FILE([log])
 262 AT_CAPTURE_FILE([log.old])
 263 AT_CHECK([ovstest test-unixctl --log-file=`pwd`/log --pidfile --detach --no-chdir],
 264   [0], [], [ignore])
 265 AT_CHECK([vlog_filt log], [0], [opened log file
 266 Entering run loop.
 267 ])
 268
 269 AT_CHECK([APPCTL -t test-unixctl log message])
 270 AT_CHECK([APPCTL -t test-unixctl log message2])
 271
 272 # After closing the log file, message3 won't appear anywhere.
 273 AT_CHECK([APPCTL -t test-unixctl vlog/close])
 274 mv log log.old
 275 AT_CHECK([APPCTL -t test-unixctl log message3])
 276
 277 # Closing the log file again is harmless.
 278 AT_CHECK([APPCTL -t test-unixctl vlog/close])
 279 AT_CHECK([APPCTL -t test-unixctl log message4])
 280
 281 # After reopening the log file, further messages start appearing again.
 282 AT_CHECK([APPCTL -t test-unixctl vlog/reopen])
 283 AT_CHECK([APPCTL -t test-unixctl log message5])
 284 AT_CHECK([APPCTL -t test-unixctl exit])
 285
 286 AT_CHECK([vlog_filt log.old], [0], [dnl
 287 opened log file
 288 Entering run loop.
 289 message
 290 message2
 291 ])
 292 AT_CHECK([vlog_filt log], [0], [dnl
 293 opened log file
 294 message5
 295 ])
 296 AT_CLEANUP
 297
 298 AT_SETUP([vlog - vlog/close - Python3])
 299 on_exit 'kill `cat test-unixctl.py.pid`'
 300
 301 AT_CAPTURE_FILE([log])
 302 AT_CAPTURE_FILE([log.old])
 303 AT_CHECK([$PYTHON3 $srcdir/test-unixctl.py --log-file=`pwd`/log --pidfile --detach --no-chdir])
 304
 305 AT_CHECK([APPCTL -t test-unixctl.py log message])
 306 AT_CHECK([APPCTL -t test-unixctl.py log message2])
 307
 308 # After closing the log file, message3 won't appear anywhere.
 309 AT_CHECK([APPCTL -t test-unixctl.py vlog/close])
 310 mv log log.old
 311 AT_CHECK([APPCTL -t test-unixctl.py log message3])
 312
 313 # Closing the log file again is harmless.
 314 AT_CHECK([APPCTL -t test-unixctl.py vlog/close])
 315 AT_CHECK([APPCTL -t test-unixctl.py log message4])
 316
 317 # After reopening the log file, further messages start appearing again.
 318 AT_CHECK([APPCTL -t test-unixctl.py vlog/reopen])
 319 AT_CHECK([APPCTL -t test-unixctl.py log message5])
 320 AT_CHECK([APPCTL -t test-unixctl.py exit])
 321
 322 AT_CHECK([sed 's/.*|//' log.old], [0], [dnl
 323  Entering run loop.
 324  message
 325  message2
 326 ])
 327 AT_CHECK([sed 's/.*|//' log], [0], [dnl
 328  message5
 329 ])
 330 AT_CLEANUP
 331
 332 AT_SETUP([vlog - vlog/set and vlog/list - C])
 333 on_exit 'kill `cat test-unixctl.pid`'
 334
 335 AT_CAPTURE_FILE([log])
 336 AT_CHECK([ovstest test-unixctl --log-file=`pwd`/log --pidfile --detach --no-chdir],
 337   [0], [], [ignore])
 338 AT_CHECK([vlog_filt log], [0], [opened log file
 339 Entering run loop.
 340 ])
 341
 342 AT_CHECK([APPCTL -t test-unixctl vlog/list | sed -n '1,2p
 343 /test_unixctl /p; /daemon /p'], [0], [dnl
 344                  console    syslog    file
 345                  -------    ------    ------
 346 daemon             OFF       INFO       INFO
 347 test_unixctl       OFF       INFO       INFO
 348 ])
 349
 350 AT_CHECK([APPCTL -t test-unixctl vlog/set daemon:syslog:err])
 351 AT_CHECK([APPCTL -t test-unixctl vlog/set file:dbg])
 352 AT_CHECK([APPCTL -t test-unixctl vlog/set nonexistent], [2], [],
 353   [no destination, level, or module "nonexistent"
 354 ovs-appctl: test-unixctl: server returned an error
 355 ])
 356 AT_CHECK([APPCTL -t test-unixctl vlog/list | sed -n '1,2p
 357 /test_unixctl /p; /daemon /p'], [0], [dnl
 358                  console    syslog    file
 359                  -------    ------    ------
 360 daemon             OFF        ERR        DBG
 361 test_unixctl       OFF       INFO        DBG
 362 ])
 363
 364 AT_CHECK([APPCTL -t test-unixctl vlog/set pattern], [2], [],
 365   [missing destination
 366 ovs-appctl: test-unixctl: server returned an error
 367 ])
 368 AT_CHECK([APPCTL -t test-unixctl vlog/set pattern:nonexistent], [2], [],
 369   [unknown destination "nonexistent"
 370 ovs-appctl: test-unixctl: server returned an error
 371 ])
 372 AT_CHECK([APPCTL -t test-unixctl vlog/set pattern:file:'I<3OVS|%m'])
 373 AT_CHECK([APPCTL -t test-unixctl log patterntest])
 374 AT_CHECK([grep -q 'I<3OVS' log])
 375 OVS_APP_EXIT_AND_WAIT([test-unixctl])
 376 AT_CLEANUP
 377
 378 AT_SETUP([vlog - vlog/set and vlog/list - Python3])
 379 on_exit 'kill `cat test-unixctl.py.pid`'
 380
 381 AT_CAPTURE_FILE([log])
 382 AT_CHECK([$PYTHON3 $srcdir/test-unixctl.py --log-file=`pwd`/log --pidfile --detach --no-chdir])
 383
 384 AT_CHECK([APPCTL -t test-unixctl.py vlog/list], [0], [dnl
 385                  console    syslog    file
 386                  -------    ------    ------
 387 daemon            info       info       info
 388 fatal-signal      info       info       info
 389 jsonrpc           info       info       info
 390 poller            info       info       info
 391 reconnect         info       info       info
 392 socket_util       info       info       info
 393 stream            info       info       info
 394 test-unixctl      info       info       info
 395 unixctl_server    info       info       info
 396 ])
 397
 398    AT_CHECK([APPCTL -t test-unixctl.py vlog/set daemon:syslog:err])
 399    AT_CHECK([APPCTL -t test-unixctl.py vlog/set file:dbg])
 400    AT_CHECK([APPCTL -t test-unixctl.py vlog/set nonexistent], [0],
 401   [no destination, level, or module "nonexistent"
 402 ])
 403    AT_CHECK([APPCTL -t test-unixctl.py vlog/list], [0], [dnl
 404                  console    syslog    file
 405                  -------    ------    ------
 406 daemon            info        err        dbg
 407 fatal-signal      info       info        dbg
 408 jsonrpc           info       info        dbg
 409 poller            info       info        dbg
 410 reconnect         info       info        dbg
 411 socket_util       info       info        dbg
 412 stream            info       info        dbg
 413 test-unixctl      info       info        dbg
 414 unixctl_server    info       info        dbg
 415 ])
 416
 417 AT_CHECK([APPCTL -t test-unixctl.py vlog/set pattern], [0],
 418   [Please supply a valid pattern and destination
 419 ])
 420 AT_CHECK([APPCTL -t test-unixctl.py vlog/set pattern:nonexistent], [0],
 421   [Destination nonexistent does not exist
 422 ])
 423 AT_CHECK([APPCTL -t test-unixctl.py vlog/set pattern:file:'I<3OVS|%m'])
 424 AT_CHECK([APPCTL -t test-unixctl.py log patterntest])
 425 AT_CHECK([grep -q 'I<3OVS' log])
 426 AT_CLEANUP
 427
 428 AT_SETUP([vlog - RFC5424 facility])
 429 on_exit 'kill `cat ovsdb-server.pid`'
 430
 431 dnl Create database.
 432 touch .conf.db.~lock~
 433 AT_CHECK([ovsdb-tool create conf.db $abs_top_srcdir/vswitchd/vswitch.ovsschema])
 434
 435 AT_CHECK([ovsdb-server --detach --no-chdir --pidfile \
 436           --remote=punix:$OVS_RUNDIR/db.sock -vPATTERN:file:"<%B>1 %A %m" \
 437           --log-file], [0], [], [stderr])
 438 OVS_APP_EXIT_AND_WAIT([ovsdb-server])
 439
 440 # A default facility of LOG_LOCAL0 while writing to file.
 441 AT_CHECK([head -1 ovsdb-server.log | awk '{print $1}'], [0], [<133>1
 442 ])
 443 rm ovsdb-server.log
 444
 445 AT_CHECK([ovsdb-server --detach --no-chdir --pidfile \
 446           --remote=punix:$OVS_RUNDIR/db.sock -vPATTERN:file:"<%B>1 %A %m" \
 447           -vFACILITY:daemon --log-file], [0], [], [stderr])
 448
 449 AT_CHECK([head -1 ovsdb-server.log | awk '{print $1}'], [0], [<29>1
 450 ])
 451
 452 AT_CHECK([ovs-appctl -t ovsdb-server vlog/set FACILITY:invalid], [2], [],
 453 [invalid facility
 454 ovs-appctl: ovsdb-server: server returned an error
 455 ])
 456
 457 AT_CHECK([ovs-appctl -t ovsdb-server vlog/set FACILITY:local7])
 458 AT_CHECK([ovs-appctl -t ovsdb-server vlog/set ANY:file:DBG])
 459 OVS_APP_EXIT_AND_WAIT([ovsdb-server])
 460
 461 AT_CHECK([tail -1 ovsdb-server.log | awk '{print $1}'], [0], [<191>1
 462 ])
 463 AT_CLEANUP
 464
 465 AT_SETUP([vlog - RFC5424 facility - Python3])
 466 on_exit 'kill `cat test-unixctl.py.pid`'
 467
 468 AT_CHECK([$PYTHON3 $srcdir/test-unixctl.py --log-file=`pwd`/log --pidfile \
 469 -vFACILITY:invalid --detach --no-chdir], [1], [], [test-unixctl.py: processing "FACILITY:invalid": Facility invalid is invalid
 470 ])
 471
 472 AT_CHECK([$PYTHON3 $srcdir/test-unixctl.py --log-file=`pwd`/log --pidfile \
 473 -vFACILITY:daemon --detach --no-chdir])
 474
 475 AT_CHECK([ovs-appctl -t test-unixctl.py vlog/set FACILITY:invalid], [0],
 476 [Facility invalid is invalid
 477 ])
 478
 479 AT_CHECK([ovs-appctl -t test-unixctl.py vlog/set FACILITY:local0])
 480 AT_CLEANUP