連続アクション実行時、メッセージのマクロ値が別の内容に変わる?

いつも本FORUMを参考にさせていただいています。
以下、長文で恐縮ですがよろしくお願いいたします。

●内容

Zabbixの評価として、zabbix_senderコマンドを連続投入し、アクションにて その内容をテキストログへ出力する試験を行っています。
その結果、アクションにより生成されたテキストログの内容が、トリガと正しく一対一対応せず、メッセージ内容(マクロ値?)が、別のアクションの内容に変わるような(?)事象が見られています。

過去に同様な事例や回避策が もしございましたらご教授いただきたいと思い投稿いたします。
#もしくは、当方の使い方がまずいのか、Zabbixの機能制限なのか、etc

●環境
 ・サーバ HP DL360G7
 ・OS   CentOS5.5(final)
 ・Zabbix 1.8.4 JP
 ・DB   MySQL 5.0.77
 ・Browser FireFox

●ホスト snmptrapの設定
  名前 snmptrap
  グループ snmptrap
  ステータス 有効
  (その他項目はブランクor無し)
 
 ・アクション設定
  名前 ZabbixServerイベントログ出力
  イベントソース トリガー
  エスカレーションを有効 (チェック無し)
  デフォルトの件名/メッセージ (ブランク)
  リカバリメッセージ (チェック無し)
  ステータス 有効

 ・アクションのオペレーション
  オペレーションのタイプ メッセージの送信
  メッセージの送信先 ユーザ "logging"
  次のメディアのみ使用 eventlog
  ユーザのメディア eventlog localhost 1-7,00:00-24:00; NIWAHD
  デフォルトのメッセージ (チェック無し)
  件名 (ブランク)
  メッセージ NOW{DATE} {TIME} :EVENT {EVENT.DATE} {EVENT.TIME}:{TRIGGER.NAME}:EVENTID={EVENT.ID}:TRIGGERID={TRIGGER.ID} :TRIG.LAST={{HOSTNAME}:{TRIGGER.KEY}.last(0)}

 ・アクションのコンディション
  トリガーの値 = "障害"

 ・トリガー設定
  深刻度  ステータス 名前       条件式                イベント生成
  重度の障害  有効    CRITICAL_trap {snmptrap:snmptrap.str(CRITICAL)}=1  ノーマル
  致命的な障害 有効    FATAL_trap {snmptrap:snmptrap.str(FATAL)}=1   ノーマル

●ユーザ loggingの設定

  アカウント名 logging
  名前 logging
  名字 logging
  ユーザの種類 Zabbix特権管理者
  グループ ZabbixAdmin
  言語 日本語
  メディア eventlog localhost 1-7,00:00-24:00; NIWAHD 有効

●メディア eventlogの設定
  説明 タイプ 詳細
  eventlog スクリプト スクリプト名: "eventlog.sh"

●スクリプト eventlog.shの内容

# cat /etc/zabbix/alertscripts/eventlog.sh
#!/bin/sh

CMD=/bin/echo
MSG=$3 $4 $5 $6

$CMD $MSG" " >> /var/log/zabbix/zabbix_event.log

●テスト結果

 ・送信したテストデータ

  Zabbixサーバ上で、zabbix_senderを使用し、以下の様な FATAL、CRITICALを交互、かつ行末の数字を0〜99までカウントアップした文字列を100行 送信。
  (zabbix_senderコマンド間に、特にウェイト無し)
  
  # /usr/bin/zabbix_sender -c /etc/zabbix/zabbix_agentd.conf -s snmptrap -k snmptrap -o 'Fri Apr 15 15:05:16 JST 2011:FATAL :sender test#4#:0 '
  # /usr/bin/zabbix_sender -c /etc/zabbix/zabbix_agentd.conf -s snmptrap -k snmptrap -o 'Fri Apr 15 15:05:16 JST 2011:CRITICAL:sender test#4#:1 '
   <中略>
  # /usr/bin/zabbix_sender -c /etc/zabbix/zabbix_agentd.conf -s snmptrap -k snmptrap -o 'Fri Apr 15 15:05:16 JST 2011:FATAL :sender test#4#:98'
  # /usr/bin/zabbix_sender -c /etc/zabbix/zabbix_agentd.conf -s snmptrap -k snmptrap -o 'Fri Apr 15 15:05:16 JST 2011:CRITICAL:sender test#4#:99'

 ・zabbix 最新データ snmptrap:snmptrap
 
  → 送信したデータがきちんと受信できています。
    出力された行数は100であり、送信したテストデータと一致。
 
 タイムスタンプ 値
2011-04-15 15:19:06 1302848346 Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99
2011-04-15 15:19:06 1302848346 Fri Apr 15 15:19:06 JST 2011:FATAL :sender test#4#:98
2011-04-15 15:19:06 1302848346 Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:97
2011-04-15 15:19:06 1302848346 Fri Apr 15 15:19:06 JST 2011:FATAL :sender test#4#:96
2011-04-15 15:19:06 1302848346 Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:95
2011-04-15 15:19:06 1302848346 Fri Apr 15 15:19:06 JST 2011:FATAL :sender test#4#:94

 <中略>

2011-04-15 15:19:06 1302848346 Fri Apr 15 15:19:06 JST 2011:FATAL :sender test#4#:2
2011-04-15 15:19:06 1302848346 Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:1
2011-04-15 15:19:06 1302848346 Fri Apr 15 15:19:06 JST 2011:FATAL :sender test#4#:0

 ・アクションにてキックされ、生成されたイベントログ(/var/log/zabbix/zabbix_event.log)
 
  出力された行数は100行あり、送信したテストデータと行数は一致。
  ただ、TRIGGER.NAMEと、TRIGGER.KEYで渡されるメッセージ部が一致しない箇所がある。
  (行末の数字が”99”となっているので、アクション起動したときの最後のTRIGGER.KEYに代わってしまっている?)

NOW2011.04.15 15:19:08 :EVENT 2011.04.15 15:19:06:FATAL_trap:EVENTID=83083:TRIGGERID=13054 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:FATAL :sender test#4#:2
NOW2011.04.15 15:19:08 :EVENT 2011.04.15 15:19:06:CRITICAL_trap:EVENTID=83085:TRIGGERID=13053 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:FATAL :sender test#4#:2
NOW2011.04.15 15:19:09 :EVENT 2011.04.15 15:19:06:FATAL_trap:EVENTID=83088:TRIGGERID=13054 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:FATAL :sender test#4#:2
NOW2011.04.15 15:19:15 :EVENT 2011.04.15 15:19:06:CRITICAL_trap:EVENTID=83089:TRIGGERID=13053 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99
NOW2011.04.15 15:19:15 :EVENT 2011.04.15 15:19:06:FATAL_trap:EVENTID=83092:TRIGGERID=13054 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99
NOW2011.04.15 15:19:15 :EVENT 2011.04.15 15:19:06:CRITICAL_trap:EVENTID=83093:TRIGGERID=13053 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99

 <中略>

NOW2011.04.15 15:19:15 :EVENT 2011.04.15 15:19:06:CRITICAL_trap:EVENTID=83217:TRIGGERID=13053 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99
NOW2011.04.15 15:19:15 :EVENT 2011.04.15 15:19:06:FATAL_trap:EVENTID=83220:TRIGGERID=13054 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99
NOW2011.04.15 15:19:16 :EVENT 2011.04.15 15:19:06:CRITICAL_trap:EVENTID=83221:TRIGGERID=13053 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99
NOW2011.04.15 15:19:16 :EVENT 2011.04.15 15:19:06:FATAL_trap:EVENTID=83224:TRIGGERID=13054 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99

 <中略>

NOW2011.04.15 15:19:16 :EVENT 2011.04.15 15:19:06:FATAL_trap:EVENTID=83276:TRIGGERID=13054 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99
NOW2011.04.15 15:19:16 :EVENT 2011.04.15 15:19:06:CRITICAL_trap:EVENTID=83277:TRIGGERID=13053 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99
NOW2011.04.15 15:19:16 :EVENT 2011.04.15 15:19:06:FATAL_trap:EVENTID=83280:TRIGGERID=13054 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99
NOW2011.04.15 15:19:16 :EVENT 2011.04.15 15:19:06:CRITICAL_trap:EVENTID=83281:TRIGGERID=13053 :TRIG.LAST=Fri Apr 15 15:19:06 JST 2011:CRITICAL:sender test#4#:99

以上、よろしくお願いします。

コメント表示オプション

お好みのコメント表示方法を選び「設定の保存」をクリックすると変更が反映されます。
ユーザー kodai の写真

アクションで{hostname:itemkey.last(0)}や、{ITEM.VALUE}、{ITEM.LASTVALUE}を使った場合で、かつログやトラップ、zabbix_senderなどで1秒間に複数のデータが記録された場合、マクロの展開後に異なったデータを使ってしまう場合があるのはZabbix 1.8の既知の問題です。

時期バージョンである2.0ではすでに対応されているのですが、1.8では対応予定はないため、これらのマクロを使用する場合は注意が必要です。

ユーザー adtazy の写真

kodai様、adtazyと申します。

ご確認・ご回答ありがとうございます。
本件、既知の問題との事、了解しました。

ちなみに、本問題のBUG番号(ZBX-xxx)と、Ver2.0 JP版のリリース時期(見込みで結構です)が もしお分かりになりましたら、参考までにご教授いただけると幸いです。

以上、よろしくお願いします。

ユーザー kodai の写真

この件はバグではなく、1.8の仕様として扱われています。なので、特にバグ番号はありません。

2.0のリリース時期は正式にはアナウンスされていないのですが、今年の9/30-10/1に開催されるZabbix Conference 2011の開催時期とあわせてZabbix 2.0のダウンロードが開始されるような記述も見かけたので、今の時点ではその時をターゲットにしているのだと思います。

ユーザー adtazy の写真

kodai様、adtazyと申します。

ご回答ありがとうございました。

内容了解しました。