1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
135
136
137
138
139
140
141
142
143
144
145
146
147
148
149
150
151
152
153
154
155
156
157
158
159
160
161
162
163
164
165
166
167
168
169
170
171
172
173
174
175
176
177
178
179
180
181
182
183
184
185
186
187
188
189
190
191
192
193
194
195
196
197
198
199
200
201
202
203
204
205
206
207
208
209
210
211
212
213
214
215
216
217
218
219
|
#!/usr/bin/env python
# -*- coding: utf-8 -*-
#
# Copyright (c) 2014-2016, NORDUnet A/S.
# See LICENSE for licensing information.
#
# Fetch new entries from all storage nodes.
# See catlfish/doc/merge.txt for more about the merge process.
#
import sys
import struct
import subprocess
import requests
from time import sleep
from mergetools import get_logorder, verify_entry, get_new_entries, \
chunks, fsync_logorder, get_entries, add_to_logorder, \
hexencode, parse_args, perm
from certtools import timing_point, write_file, create_ssl_context, http_request
import json
def reportstatus(statusservers, own_key, target, variable, status):
for statusserver in statusservers:
do_reportstatus(statusserver["name"], "https://%s/" % statusserver["address"], own_key, target, variable, status)
def do_reportstatus(node, baseurl, own_key, target, variable, status):
try:
(ownname, _) = own_key
result = http_request(baseurl + "plop/v1/status/merge_fetch",
json.dumps([{"source":ownname, "target":target, "key": variable, "value": status}]), key=own_key,
verifynode=node)
return json.loads(result)
except requests.exceptions.HTTPError, e:
print >>sys.stderr, "ERROR: reportstatus", e.response
sys.exit(1)
except ValueError, e:
print >>sys.stderr, "==== FAILED REQUEST ===="
print >>sys.stderr, target, variable, status
print >>sys.stderr, "======= RESPONSE ======="
print >>sys.stderr, e.response
print >>sys.stderr, "========================"
sys.stderr.flush()
raise e
report_timing_point_counter = 0
def report_timing_point(timer_dict, statusservers, own_key, target):
if timer_dict["deltatimes"]:
(name, deltatime) = timer_dict["deltatimes"][-1]
stoptime = timer_dict["lasttime"]
starttime = stoptime - deltatime
global report_timing_point_counter
report_timing_point_counter += 1
starttime_unix = starttime * 1000.0
reportbench(statusservers, own_key, target, name, report_timing_point_counter, starttime_unix, deltatime*1000.0)
def reportbench(statusservers, own_key, target, tag, seq, starttime, elapsed):
for statusserver in statusservers:
do_reportbench(statusserver["name"], "https://%s/" % statusserver["address"], own_key, target, tag, seq, starttime, elapsed)
def do_reportbench(node, baseurl, own_key, target, tag, seq, starttime, elapsed):
try:
(ownname, _) = own_key
result = http_request(baseurl + "plop/v1/bench/merge_fetch",
json.dumps([{"source":ownname, "target":target, "tag": tag, "seq": seq, "starttime": starttime, "elapsed": elapsed}]), key=own_key,
verifynode=node)
return json.loads(result)
except requests.exceptions.HTTPError, e:
print >>sys.stderr, "ERROR: reportstatus", e.response
sys.exit(1)
except ValueError, e:
print >>sys.stderr, "==== FAILED REQUEST ===="
print >>sys.stderr, target, tag, seq, starttime, elapsed
print >>sys.stderr, "======= RESPONSE ======="
print >>sys.stderr, e.response
print >>sys.stderr, "========================"
sys.stderr.flush()
raise e
def merge_fetch(args, config, localconfig, currentsizefile):
paths = localconfig["paths"]
storagenodes = config["storagenodes"]
mergedb = paths["db"]
logorderfile = mergedb + "/logorder"
chainsdb = perm(localconfig["dbbackend"], mergedb + "/chains")
own_key = (localconfig["nodename"],
"%s/%s-private.pem" % (paths["privatekeys"],
localconfig["nodename"]))
assert(localconfig["nodename"] == config["primarymergenode"])
statusservers = config.get("statusservers")
timing = timing_point()
report_timing_point(timing, statusservers, own_key, None)
logorder = get_logorder(logorderfile)
certsinlog = set(logorder)
timing_point(timing, "get logorder")
report_timing_point(timing, statusservers, own_key, None)
new_entries_per_node = {}
new_entries = set()
entries_to_fetch = {}
for storagenode in storagenodes:
try:
print >>sys.stderr, "getting new entries from", storagenode["name"]
sys.stderr.flush()
new_entries_per_node[storagenode["name"]] = \
set(get_new_entries(storagenode["name"],
"https://%s/" % storagenode["address"],
own_key, paths))
new_entries.update(new_entries_per_node[storagenode["name"]])
entries_to_fetch[storagenode["name"]] = []
except requests.exceptions.ConnectionError:
pass
timing_point(timing, "get new entries")
report_timing_point(timing, statusservers, own_key, storagenode["name"])
new_entries -= certsinlog
print >>sys.stderr, "adding", len(new_entries), "entries"
sys.stderr.flush()
reportstatus(statusservers, own_key, own_key[0], "total", len(certsinlog) + len(new_entries))
for ehash in new_entries:
for storagenode in storagenodes:
if storagenode["name"] not in new_entries_per_node:
continue
if ehash in new_entries_per_node[storagenode["name"]]:
entries_to_fetch[storagenode["name"]].append(ehash)
break
verifycert = subprocess.Popen(
[paths["verifycert_bin"], paths["knownroots"]],
stdin=subprocess.PIPE, stdout=subprocess.PIPE)
noncommitted = 0
added_entries = 0
for storagenode in storagenodes:
if storagenode["name"] not in entries_to_fetch:
continue
print >>sys.stderr, "getting %d entries from %s:" % \
(len(entries_to_fetch[storagenode["name"]]), storagenode["name"]),
sys.stderr.flush()
with requests.sessions.Session() as session:
for chunk in chunks(entries_to_fetch[storagenode["name"]], 100):
entries = get_entries(storagenode["name"],
"https://%s/" % storagenode["address"],
own_key, paths, chunk, session=session)
for ehash in chunk:
entry = entries[ehash]
verify_entry(verifycert, entry, ehash)
chainsdb.add(ehash, entry)
noncommitted += 1
add_to_logorder(logorderfile, ehash)
logorder.append(ehash)
certsinlog.add(ehash)
added_entries += 1
if noncommitted >= 1000:
chainsdb.commit()
fsync_logorder(logorderfile)
noncommitted = 0
tree_size = len(logorder)
currentsize = {"index": tree_size - 1, "hash": hexencode(logorder[tree_size-1])}
write_file(currentsizefile, currentsize)
reportstatus(statusservers, own_key, own_key[0], "fetched", tree_size)
print >>sys.stderr, added_entries,
sys.stderr.flush()
print >>sys.stderr
sys.stderr.flush()
chainsdb.commit()
fsync_logorder(logorderfile)
timing_point(timing, "add entries")
report_timing_point(timing, statusservers, own_key, None)
print >>sys.stderr, "added", added_entries, "entries"
sys.stderr.flush()
verifycert.communicate(struct.pack("I", 0))
if args.timing:
print >>sys.stderr, "timing: merge_fetch:", timing["deltatimes"]
sys.stderr.flush()
tree_size = len(logorder)
reportstatus(statusservers, own_key, own_key[0], "fetched", tree_size)
if tree_size == 0:
return (0, '')
else:
return (tree_size, logorder[tree_size-1])
def main():
"""
Fetch new entries from all storage nodes.
Indicate current position by writing the index in the logorder file
(0-based) to the 'fetched' file.
Sleep some and start over.
"""
args, config, localconfig = parse_args()
paths = localconfig["paths"]
mergedb = paths["db"]
currentsizefile = mergedb + "/fetched"
create_ssl_context(cafile=paths["https_cacertfile"])
while True:
logsize, last_hash = merge_fetch(args, config, localconfig, currentsizefile)
currentsize = {"index": logsize - 1, "hash": hexencode(last_hash)}
#print >>sys.stderr, "DEBUG: writing to", currentsizefile, ":", currentsize
write_file(currentsizefile, currentsize)
if args.interval is None:
break
print >>sys.stderr, "sleeping", args.interval, "seconds"
sleep(args.interval)
if __name__ == '__main__':
sys.exit(main())
|
